builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1480592753.49 results: success (0) buildid: 20161201004019 builduid: d0a18ee4297b4ea883fece53f621d9ca revision: fa39ccc915c12f39eb51bd55871266f23fb5e999 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 03:45:53.486028) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 03:45:53.486945) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 03:45:53.487436) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 03:45:53.503181) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 03:45:53.503622) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-01 03:45:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.6M=0s 2016-12-01 03:45:53 (45.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116255 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 03:45:53.633800) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 03:45:53.634138) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020112 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 03:45:53.684002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 03:45:53.684380) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fa39ccc915c12f39eb51bd55871266f23fb5e999 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fa39ccc915c12f39eb51bd55871266f23fb5e999 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-01 03:45:53,944 truncating revision to first 12 chars 2016-12-01 03:45:53,944 Setting DEBUG logging. 2016-12-01 03:45:53,944 attempt 1/10 2016-12-01 03:45:53,944 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fa39ccc915c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-01 03:45:54,253 unpacking tar archive at: mozilla-aurora-fa39ccc915c1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.616922 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 03:45:54.316814) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 03:45:54.317331) ========= script_repo_revision: fa39ccc915c12f39eb51bd55871266f23fb5e999 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 03:45:54.317985) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 03:45:54.318441) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 03:45:54.329097) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-01 03:45:54.329693) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:45:54 INFO - MultiFileLogger online at 20161201 03:45:54 in /builds/slave/test 03:45:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:45:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:45:54 INFO - {'append_to_log': False, 03:45:54 INFO - 'base_work_dir': '/builds/slave/test', 03:45:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:45:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:45:54 INFO - 'branch': 'Mozilla-Aurora', 03:45:54 INFO - 'buildbot_json_path': 'buildprops.json', 03:45:54 INFO - 'config_files': ('talos/linux_config.py',), 03:45:54 INFO - 'default_actions': ('clobber', 03:45:54 INFO - 'read-buildbot-config', 03:45:54 INFO - 'download-and-extract', 03:45:54 INFO - 'populate-webroot', 03:45:54 INFO - 'create-virtualenv', 03:45:54 INFO - 'install', 03:45:54 INFO - 'run-tests'), 03:45:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:45:54 INFO - 'download_minidump_stackwalk': True, 03:45:54 INFO - 'download_symbols': 'ondemand', 03:45:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:45:54 INFO - 'tooltool.py': '/tools/tooltool.py', 03:45:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:45:54 INFO - '/tools/misc-python/virtualenv.py')}, 03:45:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:45:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:45:54 INFO - 'installer_path': 'installer.exe', 03:45:54 INFO - 'log_level': 'info', 03:45:54 INFO - 'log_name': 'talos', 03:45:54 INFO - 'log_to_console': True, 03:45:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:45:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:45:54 INFO - 'opt_config_files': (), 03:45:54 INFO - 'pip_index': False, 03:45:54 INFO - 'sps_profile': False, 03:45:54 INFO - 'sps_profile_interval': 0, 03:45:54 INFO - 'suite': 'dromaeojs-e10s', 03:45:54 INFO - 'system_bits': '32', 03:45:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:45:54 INFO - 'title': 'talos-linux64-ix-018', 03:45:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:45:54 INFO - 'use_talos_json': True, 03:45:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:45:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:45:54 INFO - 'work_dir': 'build'} 03:45:54 INFO - [mozharness: 2016-12-01 11:45:54.692124Z] Running clobber step. 03:45:54 INFO - Running pre-action listener: _resource_record_pre_action 03:45:54 INFO - Running main action method: clobber 03:45:54 INFO - rmtree: /builds/slave/test/build 03:45:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:45:55 INFO - Running post-action listener: _resource_record_post_action 03:45:55 INFO - [mozharness: 2016-12-01 11:45:55.666021Z] Finished clobber step (success) 03:45:55 INFO - [mozharness: 2016-12-01 11:45:55.666119Z] Running read-buildbot-config step. 03:45:55 INFO - Running pre-action listener: _resource_record_pre_action 03:45:55 INFO - Running main action method: read_buildbot_config 03:45:55 INFO - Using buildbot properties: 03:45:55 INFO - { 03:45:55 INFO - "project": "", 03:45:55 INFO - "product": "firefox", 03:45:55 INFO - "script_repo_revision": "production", 03:45:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:45:55 INFO - "repository": "", 03:45:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:45:55 INFO - "buildid": "20161201004019", 03:45:55 INFO - "stage_platform": "linux64-pgo", 03:45:55 INFO - "basedir": "/builds/slave/test", 03:45:55 INFO - "nightly_build": "True", 03:45:55 INFO - "buildnumber": 685, 03:45:55 INFO - "slavename": "talos-linux64-ix-018", 03:45:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:45:55 INFO - "platform": "ubuntu64_hw", 03:45:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:45:55 INFO - "branch": "mozilla-aurora", 03:45:55 INFO - "repo_path": "releases/mozilla-aurora", 03:45:55 INFO - "revision": "fa39ccc915c12f39eb51bd55871266f23fb5e999", 03:45:55 INFO - "pgo_build": "True", 03:45:55 INFO - "builduid": "d0a18ee4297b4ea883fece53f621d9ca", 03:45:55 INFO - "slavebuilddir": "test" 03:45:55 INFO - } 03:45:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 03:45:55 INFO - Running post-action listener: _resource_record_post_action 03:45:55 INFO - [mozharness: 2016-12-01 11:45:55.668593Z] Finished read-buildbot-config step (success) 03:45:55 INFO - [mozharness: 2016-12-01 11:45:55.668681Z] Running download-and-extract step. 03:45:55 INFO - Running pre-action listener: _resource_record_pre_action 03:45:55 INFO - Running main action method: download_and_extract 03:45:55 INFO - mkdir: /builds/slave/test/build/tests 03:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:55 INFO - trying https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:45:55 INFO - Downloading https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:45:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:45:56 INFO - Downloaded 1361 bytes. 03:45:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:45:56 INFO - Using the following test package requirements: 03:45:56 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:45:56 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:45:56 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:45:56 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:56 INFO - u'jsshell-linux-x86_64.zip'], 03:45:56 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:45:56 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:45:56 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:45:56 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:45:56 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:45:56 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:45:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:45:56 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:45:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:45:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:45:56 INFO - Fetch https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:45:59 INFO - Http code: 200 03:45:59 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 03:45:59 INFO - x-amz-cf-id: zAwukflYZX7odGkH65JZUpH_LARO49gkvNcxjNLn8a2-IsU-mrzYBw== 03:45:59 INFO - x-amz-version-id: sxOdiyESaKdZOAB9pp0q.PUwpix9qE_6 03:46:00 INFO - Expected file size: 21957847 03:46:00 INFO - Obtained file size: 21957847 03:46:03 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:46:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:46:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:46:03 INFO - Fetch https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:46:04 INFO - Http code: 200 03:46:04 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 03:46:04 INFO - x-amz-cf-id: I1GMmOk7qcNkjmLb81n7emKYvHq2KMnb1hVMk-LQTK8crZBeE1IkdQ== 03:46:04 INFO - x-amz-version-id: sxOdiyESaKdZOAB9pp0q.PUwpix9qE_6 03:46:04 INFO - Expected file size: 21957847 03:46:04 INFO - Obtained file size: 21957847 03:46:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 03:46:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:46:09 INFO - Fetch https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:46:09 INFO - Http code: 200 03:46:09 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 03:46:09 INFO - x-amz-cf-id: oCglPmezK_56RpFM9E4sFjEgxwFvczNNZVYmJg6jB6CgLMXy7E2Ukg== 03:46:09 INFO - x-amz-version-id: bjoJxOcVCoVqQDu1SUBWfGSku9KoKyhX 03:46:09 INFO - Expected file size: 14409038 03:46:09 INFO - Obtained file size: 14409038 03:46:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:10 INFO - trying https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:46:10 INFO - Downloading https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:46:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:46:11 INFO - Downloaded 63986952 bytes. 03:46:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:46:11 INFO - mkdir: /builds/slave/test/properties 03:46:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:46:11 INFO - Writing to file /builds/slave/test/properties/build_url 03:46:11 INFO - Contents: 03:46:11 INFO - build_url:https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:46:12 INFO - Running post-action listener: _resource_record_post_action 03:46:12 INFO - Running post-action listener: set_extra_try_arguments 03:46:12 INFO - [mozharness: 2016-12-01 11:46:12.160534Z] Finished download-and-extract step (success) 03:46:12 INFO - [mozharness: 2016-12-01 11:46:12.160759Z] Running populate-webroot step. 03:46:12 INFO - Running pre-action listener: _resource_record_pre_action 03:46:12 INFO - Running main action method: populate_webroot 03:46:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:46:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:46:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:46:12 INFO - '--tppagecycles', 03:46:12 INFO - '7'], 03:46:12 INFO - 'tests': ['tsvgm']}}, 03:46:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:46:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:46:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:46:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:46:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:46:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:46:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:12 INFO - 'talos_options': ['--disable-e10s'], 03:46:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:12 INFO - 'talos_options': ['--disable-e10s'], 03:46:12 INFO - 'tests': ['damp', 'tps']}, 03:46:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:12 INFO - 'tests': ['damp', 'tps']}, 03:46:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:46:12 INFO - 'tests': ['dromaeo_dom']}, 03:46:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:46:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:46:12 INFO - 'tests': ['basic_compositor_video']}, 03:46:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:46:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:46:12 INFO - 'tests': ['a11yr', 03:46:12 INFO - 'ts_paint', 03:46:12 INFO - 'tpaint', 03:46:12 INFO - 'sessionrestore', 03:46:12 INFO - 'sessionrestore_no_auto_restore', 03:46:12 INFO - 'tabpaint']}, 03:46:12 INFO - 'other-e10s': {'tests': ['a11yr', 03:46:12 INFO - 'ts_paint', 03:46:12 INFO - 'tpaint', 03:46:12 INFO - 'sessionrestore', 03:46:12 INFO - 'sessionrestore_no_auto_restore', 03:46:12 INFO - 'tabpaint']}, 03:46:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:46:12 INFO - 'ts_paint', 03:46:12 INFO - 'tpaint', 03:46:12 INFO - 'sessionrestore', 03:46:12 INFO - 'sessionrestore_no_auto_restore', 03:46:12 INFO - 'tabpaint']}, 03:46:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:46:12 INFO - 'ts_paint', 03:46:12 INFO - 'tpaint', 03:46:12 INFO - 'sessionrestore', 03:46:12 INFO - 'sessionrestore_no_auto_restore', 03:46:12 INFO - 'tabpaint']}, 03:46:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:46:12 INFO - 'tests': ['a11yr', 03:46:12 INFO - 'ts_paint', 03:46:12 INFO - 'tpaint', 03:46:12 INFO - 'sessionrestore', 03:46:12 INFO - 'sessionrestore_no_auto_restore', 03:46:12 INFO - 'tabpaint']}, 03:46:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:46:12 INFO - 'tests': ['a11yr', 03:46:12 INFO - 'ts_paint', 03:46:12 INFO - 'tpaint', 03:46:12 INFO - 'sessionrestore', 03:46:12 INFO - 'sessionrestore_no_auto_restore', 03:46:12 INFO - 'tabpaint']}, 03:46:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:46:12 INFO - 'tests': ['tsvgx', 03:46:12 INFO - 'tsvgr_opacity', 03:46:12 INFO - 'tart', 03:46:12 INFO - 'tscrollx', 03:46:12 INFO - 'cart']}, 03:46:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:46:12 INFO - 'tsvgr_opacity', 03:46:12 INFO - 'tart', 03:46:12 INFO - 'tscrollx', 03:46:12 INFO - 'cart']}, 03:46:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:12 INFO - 'talos_options': ['--disable-e10s'], 03:46:12 INFO - 'tests': ['tp5o']}, 03:46:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:12 INFO - 'tests': ['tp5o']}, 03:46:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:12 INFO - 'talos_options': ['--disable-e10s', 03:46:12 INFO - '--xperf_path', 03:46:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:12 INFO - 'tests': ['tp5n']}, 03:46:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:12 INFO - 'talos_options': ['--xperf_path', 03:46:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:12 INFO - 'tests': ['tp5n']}}, 03:46:12 INFO - 'talos.zip': {'path': '', 03:46:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:46:12 INFO - Running post-action listener: _resource_record_post_action 03:46:12 INFO - [mozharness: 2016-12-01 11:46:12.182037Z] Finished populate-webroot step (success) 03:46:12 INFO - [mozharness: 2016-12-01 11:46:12.182125Z] Running create-virtualenv step. 03:46:12 INFO - Running pre-action listener: _resource_record_pre_action 03:46:12 INFO - Running main action method: create_virtualenv 03:46:12 INFO - Creating virtualenv /builds/slave/test/build/venv 03:46:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:46:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:46:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:46:12 INFO - Using real prefix '/usr' 03:46:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:46:12 INFO - Installing distribute.............................................................................................................................................................................................done. 03:46:14 INFO - Installing pip.................done. 03:46:14 INFO - Return code: 0 03:46:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:46:14 INFO - Reading from file tmpfile_stdout 03:46:14 INFO - Output received: 03:46:14 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:46:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd9616ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:46:14 INFO - Using env: {'DISPLAY': ':0', 03:46:14 INFO - 'HOME': '/home/cltbld', 03:46:14 INFO - 'LANG': 'en_US.UTF-8', 03:46:14 INFO - 'LANGUAGE': 'en_US:en', 03:46:14 INFO - 'LOGNAME': 'cltbld', 03:46:14 INFO - 'MAIL': '/var/mail/cltbld', 03:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:14 INFO - 'MOZ_NO_REMOTE': '1', 03:46:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:14 INFO - 'NO_EM_RESTART': '1', 03:46:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:14 INFO - 'PWD': '/builds/slave/test', 03:46:14 INFO - 'SHELL': '/bin/bash', 03:46:14 INFO - 'SHLVL': '1', 03:46:14 INFO - 'TERM': 'linux', 03:46:14 INFO - 'TMOUT': '86400', 03:46:14 INFO - 'USER': 'cltbld', 03:46:14 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 03:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:14 INFO - '_': '/tools/buildbot/bin/python'} 03:46:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:46:15 INFO - Cleaning up... 03:46:15 INFO - Return code: 0 03:46:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd9616ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:46:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:46:15 INFO - Using env: {'DISPLAY': ':0', 03:46:15 INFO - 'HOME': '/home/cltbld', 03:46:15 INFO - 'LANG': 'en_US.UTF-8', 03:46:15 INFO - 'LANGUAGE': 'en_US:en', 03:46:15 INFO - 'LOGNAME': 'cltbld', 03:46:15 INFO - 'MAIL': '/var/mail/cltbld', 03:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:15 INFO - 'MOZ_NO_REMOTE': '1', 03:46:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:15 INFO - 'NO_EM_RESTART': '1', 03:46:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:15 INFO - 'PWD': '/builds/slave/test', 03:46:15 INFO - 'SHELL': '/bin/bash', 03:46:15 INFO - 'SHLVL': '1', 03:46:15 INFO - 'TERM': 'linux', 03:46:15 INFO - 'TMOUT': '86400', 03:46:15 INFO - 'USER': 'cltbld', 03:46:15 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 03:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:15 INFO - '_': '/tools/buildbot/bin/python'} 03:46:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:15 INFO - Downloading/unpacking psutil>=3.1.1 03:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:46:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:46:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:46:17 INFO - Installing collected packages: psutil 03:46:17 INFO - Running setup.py install for psutil 03:46:17 INFO - building 'psutil._psutil_linux' extension 03:46:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:46:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:46:17 INFO - building 'psutil._psutil_posix' extension 03:46:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:46:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:46:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:46:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:46:17 INFO - Successfully installed psutil 03:46:17 INFO - Cleaning up... 03:46:18 INFO - Return code: 0 03:46:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd9616ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:46:18 INFO - Using env: {'DISPLAY': ':0', 03:46:18 INFO - 'HOME': '/home/cltbld', 03:46:18 INFO - 'LANG': 'en_US.UTF-8', 03:46:18 INFO - 'LANGUAGE': 'en_US:en', 03:46:18 INFO - 'LOGNAME': 'cltbld', 03:46:18 INFO - 'MAIL': '/var/mail/cltbld', 03:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:18 INFO - 'MOZ_NO_REMOTE': '1', 03:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:18 INFO - 'NO_EM_RESTART': '1', 03:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:18 INFO - 'PWD': '/builds/slave/test', 03:46:18 INFO - 'SHELL': '/bin/bash', 03:46:18 INFO - 'SHLVL': '1', 03:46:18 INFO - 'TERM': 'linux', 03:46:18 INFO - 'TMOUT': '86400', 03:46:18 INFO - 'USER': 'cltbld', 03:46:18 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 03:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:18 INFO - '_': '/tools/buildbot/bin/python'} 03:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:46:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:46:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:46:20 INFO - Installing collected packages: mozsystemmonitor 03:46:20 INFO - Running setup.py install for mozsystemmonitor 03:46:20 INFO - Successfully installed mozsystemmonitor 03:46:20 INFO - Cleaning up... 03:46:20 INFO - Return code: 0 03:46:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:46:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd9616ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:46:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:46:20 INFO - Using env: {'DISPLAY': ':0', 03:46:20 INFO - 'HOME': '/home/cltbld', 03:46:20 INFO - 'LANG': 'en_US.UTF-8', 03:46:20 INFO - 'LANGUAGE': 'en_US:en', 03:46:20 INFO - 'LOGNAME': 'cltbld', 03:46:20 INFO - 'MAIL': '/var/mail/cltbld', 03:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:20 INFO - 'MOZ_NO_REMOTE': '1', 03:46:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:20 INFO - 'NO_EM_RESTART': '1', 03:46:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:20 INFO - 'PWD': '/builds/slave/test', 03:46:20 INFO - 'SHELL': '/bin/bash', 03:46:20 INFO - 'SHLVL': '1', 03:46:20 INFO - 'TERM': 'linux', 03:46:20 INFO - 'TMOUT': '86400', 03:46:20 INFO - 'USER': 'cltbld', 03:46:20 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 03:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:20 INFO - '_': '/tools/buildbot/bin/python'} 03:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:20 INFO - Downloading/unpacking jsonschema==2.5.1 03:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:46:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:22 INFO - Downloading functools32-3.2.3-2.tar.gz 03:46:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:46:22 INFO - warning: no files found matching '*.txt' 03:46:22 INFO - no previously-included directories found matching 'build' 03:46:22 INFO - no previously-included directories found matching 'dist' 03:46:22 INFO - no previously-included directories found matching '.git*' 03:46:22 INFO - Installing collected packages: jsonschema, functools32 03:46:22 INFO - Running setup.py install for functools32 03:46:23 INFO - warning: no files found matching '*.txt' 03:46:23 INFO - no previously-included directories found matching 'build' 03:46:23 INFO - no previously-included directories found matching 'dist' 03:46:23 INFO - no previously-included directories found matching '.git*' 03:46:23 INFO - Successfully installed jsonschema functools32 03:46:23 INFO - Cleaning up... 03:46:23 INFO - Return code: 0 03:46:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd9616ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:46:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:46:23 INFO - Using env: {'DISPLAY': ':0', 03:46:23 INFO - 'HOME': '/home/cltbld', 03:46:23 INFO - 'LANG': 'en_US.UTF-8', 03:46:23 INFO - 'LANGUAGE': 'en_US:en', 03:46:23 INFO - 'LOGNAME': 'cltbld', 03:46:23 INFO - 'MAIL': '/var/mail/cltbld', 03:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:23 INFO - 'MOZ_NO_REMOTE': '1', 03:46:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:23 INFO - 'NO_EM_RESTART': '1', 03:46:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:23 INFO - 'PWD': '/builds/slave/test', 03:46:23 INFO - 'SHELL': '/bin/bash', 03:46:23 INFO - 'SHLVL': '1', 03:46:23 INFO - 'TERM': 'linux', 03:46:23 INFO - 'TMOUT': '86400', 03:46:23 INFO - 'USER': 'cltbld', 03:46:23 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 03:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:23 INFO - '_': '/tools/buildbot/bin/python'} 03:46:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:46:23 INFO - Cleaning up... 03:46:23 INFO - Return code: 0 03:46:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd9616ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:46:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:46:23 INFO - Using env: {'DISPLAY': ':0', 03:46:23 INFO - 'HOME': '/home/cltbld', 03:46:23 INFO - 'LANG': 'en_US.UTF-8', 03:46:23 INFO - 'LANGUAGE': 'en_US:en', 03:46:23 INFO - 'LOGNAME': 'cltbld', 03:46:23 INFO - 'MAIL': '/var/mail/cltbld', 03:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:23 INFO - 'MOZ_NO_REMOTE': '1', 03:46:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:23 INFO - 'NO_EM_RESTART': '1', 03:46:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:23 INFO - 'PWD': '/builds/slave/test', 03:46:23 INFO - 'SHELL': '/bin/bash', 03:46:23 INFO - 'SHLVL': '1', 03:46:23 INFO - 'TERM': 'linux', 03:46:23 INFO - 'TMOUT': '86400', 03:46:23 INFO - 'USER': 'cltbld', 03:46:23 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 03:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:23 INFO - '_': '/tools/buildbot/bin/python'} 03:46:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:23 INFO - Downloading/unpacking blobuploader==1.2.4 03:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:25 INFO - Downloading blobuploader-1.2.4.tar.gz 03:46:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:46:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:46:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:26 INFO - Downloading docopt-0.6.1.tar.gz 03:46:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:46:26 INFO - Installing collected packages: blobuploader, requests, docopt 03:46:26 INFO - Running setup.py install for blobuploader 03:46:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:46:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:46:26 INFO - Running setup.py install for requests 03:46:26 INFO - Running setup.py install for docopt 03:46:26 INFO - Successfully installed blobuploader requests docopt 03:46:26 INFO - Cleaning up... 03:46:26 INFO - Return code: 0 03:46:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd9616ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:46:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:46:26 INFO - Using env: {'DISPLAY': ':0', 03:46:26 INFO - 'HOME': '/home/cltbld', 03:46:26 INFO - 'LANG': 'en_US.UTF-8', 03:46:26 INFO - 'LANGUAGE': 'en_US:en', 03:46:26 INFO - 'LOGNAME': 'cltbld', 03:46:26 INFO - 'MAIL': '/var/mail/cltbld', 03:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:26 INFO - 'MOZ_NO_REMOTE': '1', 03:46:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:26 INFO - 'NO_EM_RESTART': '1', 03:46:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:26 INFO - 'PWD': '/builds/slave/test', 03:46:26 INFO - 'SHELL': '/bin/bash', 03:46:26 INFO - 'SHLVL': '1', 03:46:26 INFO - 'TERM': 'linux', 03:46:26 INFO - 'TMOUT': '86400', 03:46:26 INFO - 'USER': 'cltbld', 03:46:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 03:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:26 INFO - '_': '/tools/buildbot/bin/python'} 03:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:46:27 INFO - Running setup.py (path:/tmp/pip-PDduqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:46:27 INFO - Running setup.py (path:/tmp/pip-GsRJIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:46:27 INFO - Running setup.py (path:/tmp/pip-BG820d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:46:27 INFO - Running setup.py (path:/tmp/pip-z1qyNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:46:27 INFO - Running setup.py (path:/tmp/pip-j2ahOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:46:27 INFO - Running setup.py (path:/tmp/pip-X7KqjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:46:27 INFO - Running setup.py (path:/tmp/pip-0_Mu4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:46:27 INFO - Running setup.py (path:/tmp/pip-WYxgkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:46:27 INFO - Running setup.py (path:/tmp/pip-2eSsED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:46:27 INFO - Running setup.py (path:/tmp/pip-KRXeOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:46:27 INFO - Running setup.py (path:/tmp/pip-ZQ_FsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:46:27 INFO - Running setup.py (path:/tmp/pip-lUAtlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:46:27 INFO - Running setup.py (path:/tmp/pip-BJ3EdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:46:28 INFO - Running setup.py (path:/tmp/pip-zEUvQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:28 INFO - Running setup.py (path:/tmp/pip-dFXK1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:46:28 INFO - Running setup.py (path:/tmp/pip-8IXXcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:46:28 INFO - Running setup.py (path:/tmp/pip-pmkIma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:46:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:46:28 INFO - Running setup.py install for manifestparser 03:46:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:46:28 INFO - Running setup.py install for mozcrash 03:46:28 INFO - Running setup.py install for mozdebug 03:46:28 INFO - Running setup.py install for mozdevice 03:46:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:46:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:46:28 INFO - Running setup.py install for mozfile 03:46:28 INFO - Running setup.py install for mozhttpd 03:46:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:46:28 INFO - Running setup.py install for mozinfo 03:46:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:46:29 INFO - Running setup.py install for mozInstall 03:46:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:46:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:46:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:46:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:46:29 INFO - Running setup.py install for mozleak 03:46:29 INFO - Running setup.py install for mozlog 03:46:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:46:29 INFO - Running setup.py install for moznetwork 03:46:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:46:29 INFO - Running setup.py install for mozprocess 03:46:29 INFO - Running setup.py install for mozprofile 03:46:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:46:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:46:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:46:29 INFO - Running setup.py install for mozrunner 03:46:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:46:29 INFO - Running setup.py install for mozscreenshot 03:46:29 INFO - Running setup.py install for moztest 03:46:30 INFO - Running setup.py install for mozversion 03:46:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:46:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:46:30 INFO - Cleaning up... 03:46:30 INFO - Return code: 0 03:46:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd9616ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:46:30 INFO - Using env: {'DISPLAY': ':0', 03:46:30 INFO - 'HOME': '/home/cltbld', 03:46:30 INFO - 'LANG': 'en_US.UTF-8', 03:46:30 INFO - 'LANGUAGE': 'en_US:en', 03:46:30 INFO - 'LOGNAME': 'cltbld', 03:46:30 INFO - 'MAIL': '/var/mail/cltbld', 03:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:30 INFO - 'MOZ_NO_REMOTE': '1', 03:46:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:30 INFO - 'NO_EM_RESTART': '1', 03:46:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:30 INFO - 'PWD': '/builds/slave/test', 03:46:30 INFO - 'SHELL': '/bin/bash', 03:46:30 INFO - 'SHLVL': '1', 03:46:30 INFO - 'TERM': 'linux', 03:46:30 INFO - 'TMOUT': '86400', 03:46:30 INFO - 'USER': 'cltbld', 03:46:30 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 03:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:30 INFO - '_': '/tools/buildbot/bin/python'} 03:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:46:30 INFO - Running setup.py (path:/tmp/pip-YlkQWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:46:30 INFO - Running setup.py (path:/tmp/pip-bZkyfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:46:30 INFO - Running setup.py (path:/tmp/pip-FPF33Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:46:30 INFO - Running setup.py (path:/tmp/pip-6HV9Si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:46:30 INFO - Running setup.py (path:/tmp/pip-Ij7BK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:46:30 INFO - Running setup.py (path:/tmp/pip-Am5t6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:46:30 INFO - Running setup.py (path:/tmp/pip-FFVp5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:46:30 INFO - Running setup.py (path:/tmp/pip-2nxIJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:46:30 INFO - Running setup.py (path:/tmp/pip-BTaTsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:46:31 INFO - Running setup.py (path:/tmp/pip-DbzvNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:46:31 INFO - Running setup.py (path:/tmp/pip-SR1BYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:46:31 INFO - Running setup.py (path:/tmp/pip-RjEaZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:46:31 INFO - Running setup.py (path:/tmp/pip-mK28uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:46:31 INFO - Running setup.py (path:/tmp/pip-bAkIdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:31 INFO - Running setup.py (path:/tmp/pip-Fp_yP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:46:31 INFO - Running setup.py (path:/tmp/pip-G9ESUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:46:31 INFO - Running setup.py (path:/tmp/pip-fjgwSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:46:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:33 INFO - Downloading blessings-1.6.tar.gz 03:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:46:33 INFO - Installing collected packages: blessings 03:46:33 INFO - Running setup.py install for blessings 03:46:33 INFO - Successfully installed blessings 03:46:33 INFO - Cleaning up... 03:46:33 INFO - Return code: 0 03:46:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:46:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:46:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:46:34 INFO - Reading from file tmpfile_stdout 03:46:34 INFO - Current package versions: 03:46:34 INFO - argparse == 1.2.1 03:46:34 INFO - blessings == 1.6 03:46:34 INFO - blobuploader == 1.2.4 03:46:34 INFO - docopt == 0.6.1 03:46:34 INFO - functools32 == 3.2.3-2 03:46:34 INFO - jsonschema == 2.5.1 03:46:34 INFO - manifestparser == 1.1 03:46:34 INFO - mozInstall == 1.12 03:46:34 INFO - mozcrash == 1.0 03:46:34 INFO - mozdebug == 0.1 03:46:34 INFO - mozdevice == 0.48 03:46:34 INFO - mozfile == 1.2 03:46:34 INFO - mozhttpd == 0.7 03:46:34 INFO - mozinfo == 0.9 03:46:34 INFO - mozleak == 0.1 03:46:34 INFO - mozlog == 3.4 03:46:34 INFO - moznetwork == 0.27 03:46:34 INFO - mozprocess == 0.23 03:46:34 INFO - mozprofile == 0.28 03:46:34 INFO - mozrunner == 6.13 03:46:34 INFO - mozscreenshot == 0.1 03:46:34 INFO - mozsystemmonitor == 0.3 03:46:34 INFO - moztest == 0.7 03:46:34 INFO - mozversion == 1.4 03:46:34 INFO - psutil == 3.1.1 03:46:34 INFO - requests == 1.2.3 03:46:34 INFO - wsgiref == 0.1.2 03:46:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd9616ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:46:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:46:34 INFO - Using env: {'DISPLAY': ':0', 03:46:34 INFO - 'HOME': '/home/cltbld', 03:46:34 INFO - 'LANG': 'en_US.UTF-8', 03:46:34 INFO - 'LANGUAGE': 'en_US:en', 03:46:34 INFO - 'LOGNAME': 'cltbld', 03:46:34 INFO - 'MAIL': '/var/mail/cltbld', 03:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:34 INFO - 'MOZ_NO_REMOTE': '1', 03:46:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:34 INFO - 'NO_EM_RESTART': '1', 03:46:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:34 INFO - 'PWD': '/builds/slave/test', 03:46:34 INFO - 'SHELL': '/bin/bash', 03:46:34 INFO - 'SHLVL': '1', 03:46:34 INFO - 'TERM': 'linux', 03:46:34 INFO - 'TMOUT': '86400', 03:46:34 INFO - 'USER': 'cltbld', 03:46:34 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 03:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:34 INFO - '_': '/tools/buildbot/bin/python'} 03:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:46:34 INFO - Cleaning up... 03:46:34 INFO - Return code: 0 03:46:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd9616ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b61d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:46:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:46:34 INFO - Using env: {'DISPLAY': ':0', 03:46:34 INFO - 'HOME': '/home/cltbld', 03:46:34 INFO - 'LANG': 'en_US.UTF-8', 03:46:34 INFO - 'LANGUAGE': 'en_US:en', 03:46:34 INFO - 'LOGNAME': 'cltbld', 03:46:34 INFO - 'MAIL': '/var/mail/cltbld', 03:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:34 INFO - 'MOZ_NO_REMOTE': '1', 03:46:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:34 INFO - 'NO_EM_RESTART': '1', 03:46:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:34 INFO - 'PWD': '/builds/slave/test', 03:46:34 INFO - 'SHELL': '/bin/bash', 03:46:34 INFO - 'SHLVL': '1', 03:46:34 INFO - 'TERM': 'linux', 03:46:34 INFO - 'TMOUT': '86400', 03:46:34 INFO - 'USER': 'cltbld', 03:46:34 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 03:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:34 INFO - '_': '/tools/buildbot/bin/python'} 03:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:46:34 INFO - Cleaning up... 03:46:34 INFO - Return code: 0 03:46:34 INFO - Running post-action listener: _resource_record_post_action 03:46:34 INFO - Running post-action listener: _start_resource_monitoring 03:46:34 INFO - Starting resource monitoring. 03:46:34 INFO - [mozharness: 2016-12-01 11:46:34.579594Z] Finished create-virtualenv step (success) 03:46:34 INFO - [mozharness: 2016-12-01 11:46:34.580094Z] Running install step. 03:46:34 INFO - Running pre-action listener: _resource_record_pre_action 03:46:34 INFO - Running main action method: install 03:46:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:46:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:46:34 INFO - Reading from file tmpfile_stdout 03:46:34 INFO - Detecting whether we're running mozinstall >=1.0... 03:46:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:46:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:46:34 INFO - Reading from file tmpfile_stdout 03:46:34 INFO - Output received: 03:46:34 INFO - Usage: mozinstall [options] installer 03:46:34 INFO - Options: 03:46:34 INFO - -h, --help show this help message and exit 03:46:34 INFO - -d DEST, --destination=DEST 03:46:34 INFO - Directory to install application into. [default: 03:46:34 INFO - "/builds/slave/test"] 03:46:34 INFO - --app=APP Application being installed. [default: firefox] 03:46:34 INFO - mkdir: /builds/slave/test/build/application 03:46:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:46:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:46:50 INFO - Reading from file tmpfile_stdout 03:46:50 INFO - Output received: 03:46:50 INFO - /builds/slave/test/build/application/firefox/firefox 03:46:50 INFO - Running post-action listener: _resource_record_post_action 03:46:50 INFO - [mozharness: 2016-12-01 11:46:50.858650Z] Finished install step (success) 03:46:50 INFO - [mozharness: 2016-12-01 11:46:50.858891Z] Running run-tests step. 03:46:50 INFO - Running pre-action listener: _resource_record_pre_action 03:46:50 INFO - Running main action method: run_tests 03:46:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:46:50 INFO - Python 2.7.3 03:46:50 INFO - Return code: 0 03:46:50 INFO - grabbing minidump binary from tooltool 03:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:46:50 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b61d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:46:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:46:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:46:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:46:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:46:50 INFO - Return code: 0 03:46:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:46:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:46:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:46:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:46:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:46:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:46:50 INFO - Using env: {'DISPLAY': ':0', 03:46:50 INFO - 'HOME': '/home/cltbld', 03:46:50 INFO - 'LANG': 'en_US.UTF-8', 03:46:50 INFO - 'LANGUAGE': 'en_US:en', 03:46:50 INFO - 'LOGNAME': 'cltbld', 03:46:50 INFO - 'MAIL': '/var/mail/cltbld', 03:46:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:46:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:50 INFO - 'MOZ_NO_REMOTE': '1', 03:46:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:50 INFO - 'NO_EM_RESTART': '1', 03:46:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:50 INFO - 'PWD': '/builds/slave/test', 03:46:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:46:50 INFO - 'SHELL': '/bin/bash', 03:46:50 INFO - 'SHLVL': '1', 03:46:50 INFO - 'TERM': 'linux', 03:46:50 INFO - 'TMOUT': '86400', 03:46:50 INFO - 'USER': 'cltbld', 03:46:50 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753', 03:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:50 INFO - '_': '/tools/buildbot/bin/python'} 03:46:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:46:51 INFO - mozversion application_buildid: 20161201004019 03:46:51 INFO - mozversion application_changeset: fa39ccc915c12f39eb51bd55871266f23fb5e999 03:46:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:46:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:46:51 INFO - mozversion application_name: Firefox 03:46:51 INFO - mozversion application_remotingname: firefox-dev 03:46:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:46:51 INFO - mozversion application_vendor: Mozilla 03:46:51 INFO - mozversion application_version: 52.0a2 03:46:51 INFO - mozversion platform_buildid: 20161201004019 03:46:51 INFO - mozversion platform_changeset: fa39ccc915c12f39eb51bd55871266f23fb5e999 03:46:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:46:51 INFO - mozversion platform_version: 52.0a2 03:46:51 INFO - using testdate: 1480592811 03:46:51 INFO - actual date: 1480592811 03:46:51 INFO - starting webserver on 'localhost:40689' 03:46:51 INFO - SUITE-START | Running 2 tests 03:46:51 INFO - TEST-START | dromaeo_css 03:46:51 INFO - operating with platform_type : linux_ 03:46:51 INFO - Initialising browser for dromaeo_css test... 03:46:51 INFO - TEST-INFO | started process 25315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcEVOrl/profile http://localhost:40689/getInfo.html) 03:46:55 INFO - PROCESS | 25315 | __metrics Screen width/height:1600/1200 03:46:55 INFO - PROCESS | 25315 | colorDepth:24 03:46:55 INFO - PROCESS | 25315 | Browser inner width/height: 1024/697 03:46:55 INFO - PROCESS | 25315 | __metrics 03:46:55 ERROR - PROCESS | 25315 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 03:46:56 INFO - TEST-INFO | 25315: exit 0 03:46:56 INFO - Browser initialized. 03:46:56 INFO - Running cycle 1/1 for dromaeo_css test... 03:46:56 INFO - TEST-INFO | started process 25448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcEVOrl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:47:08 INFO - PROCESS | 25448 | RSS: Main: 151748608 03:47:08 INFO - PROCESS | 25448 | 03:47:57 INFO - PROCESS | 25448 | 1480592877853 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:50:08 INFO - PROCESS | 25448 | Cycle 1(1): loaded http://localhost:40689/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40689/tests/dromaeo/cssquery-ext.html) 03:50:10 INFO - PROCESS | 25448 | RSS: Main: 156123136 03:50:10 INFO - PROCESS | 25448 | 03:53:12 INFO - PROCESS | 25448 | Cycle 1(1): loaded http://localhost:40689/tests/dromaeo/cssquery-ext.html (next: http://localhost:40689/tests/dromaeo/cssquery-jquery.html) 03:53:12 INFO - PROCESS | 25448 | RSS: Main: 153403392 03:53:12 INFO - PROCESS | 25448 | 03:56:14 INFO - PROCESS | 25448 | Cycle 1(1): loaded http://localhost:40689/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40689/tests/dromaeo/cssquery-mootools.html) 03:56:14 INFO - PROCESS | 25448 | RSS: Main: 152772608 03:56:14 INFO - PROCESS | 25448 | 03:59:16 INFO - PROCESS | 25448 | Cycle 1(1): loaded http://localhost:40689/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40689/tests/dromaeo/cssquery-prototype.html) 03:59:17 INFO - PROCESS | 25448 | RSS: Main: 152010752 03:59:17 INFO - PROCESS | 25448 | 04:02:19 INFO - PROCESS | 25448 | Cycle 1(1): loaded http://localhost:40689/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40689/tests/dromaeo/cssquery-yui.html) 04:02:20 INFO - PROCESS | 25448 | RSS: Main: 154398720 04:02:20 INFO - PROCESS | 25448 | 04:05:22 INFO - PROCESS | 25448 | Cycle 1(1): loaded http://localhost:40689/tests/dromaeo/cssquery-yui.html (next: http://localhost:40689/tests/dromaeo/cssquery-dojo.html) 04:05:23 INFO - PROCESS | 25448 | RSS: Main: 155201536 04:05:23 INFO - PROCESS | 25448 | 04:05:23 INFO - PROCESS | 25448 | __start_tp_report 04:05:23 INFO - PROCESS | 25448 | _x_x_mozilla_page_load 04:05:23 INFO - PROCESS | 25448 | _x_x_mozilla_page_load_details 04:05:23 INFO - PROCESS | 25448 | |i|pagename|runs| 04:05:23 INFO - PROCESS | 25448 | |0;dojo.html;3246.594175728034;3270.9836450817743;3276.6723327667223;3292.6378098409177;3295.8516866740993;5731.684757338345;5798.6230894991795;5801.82594522164;5802.448767367098;5803.477687008169;5795.971020144893;5843.035899076647;5845.7953971611005;5851.239338885949;5867.853303667411;5269.76286067127;5294.867628309304;5315.415304316522;5337.06601344765;5351.491608297206;5321.973390133044;5348;5351.892962140755;5355.491228333302;5382.515573598375;5108.748356652607;5121.820736274231;5314.734263286839;5333.57331413486;5334.1732031535175;5177.58579313654;5227.921581176304;5245.895082098336;5271.841844744664;5324.92012619811;5253.684778913277;5253.9474605253845;5268.736563171864;5275.182346736262;5345.091334473149;5792.9710351447975;5841.7371218295275;5848.795292164797;5892.116182572606;5899;6089.908651370233;6103.05402662588;6142.232220972379;6157.507399408037;6204.5967012144065;6189.752409903598;6199.566030377875;6216.160818289518;6221.440070393686;6224.657643829588;5701.372848986608;5750.769969201268;5781.392953739839;5808.651480911159;5822.0684690449325;6190.907136392958;6209.875802483925;6249.468795152463;6249.78125765596;6250.812475625738;6065.54508411862;6071.453569178795;6072.089186621954;6081.179040829431;6108.664023478663;6127.816165515042;6165.290991536031;6167.660778657128;6168.167297414881;6169.444749972435;5884.08796636522;5937.614055086406;6059.151718759377;6070.6357618543025;6097.512199024068;6187;6192.473639740672;6200.131981522591;6202.534809889276;6228.190335256388;4750.714957102585;4758.476567577563;4763.523647635278;4766.428028636586;4787.257975013878;4146;4151.605597468236;4207.537170911197;4256.106217694257;4287.528371879091;5849.61977471463;5861.501772349398;5885.264341957255;5888.175655408247;5945.346011938684;5986.610870293504;6140.539459540552;6168.938310616926;6183.103449999725;6191.907121393183;5778.913316300259;5868.530517558671;5945.524358051345;5961.463468287875;5997.55018373615;5325.4674532547215;5354.3574771027725;5357.142857142916;5360.892782144335;5402.027635025733;6467.062275970052;6483.935160648333;6502.479801615765;6504.674766261763;6506.41442270198;6220.129181914626;6256.186695729526;6263.906041409474;6273.341299163522;6273.96863015682;6096.9390306096375;6218.129461875251;6278.0269058296035;6444.13004244421;6476.06097115925;6191.690415479118;6201.255849298113;6206.317305096526;6208.410201030895;6212.782552610637;6286.811395658137;6297.779577714758;6299.181106456132;6303.558750887394;6335.588186767845;5788.421157884178;5892.882142357214;6010.939890601213;6136.6011209271255;6144.1398204250545;6030.276366836008;6096.116063170727;6119.541034422347;6128.080787881853;6132.969335153296;5968.4926781224085;5999.52003839683;6022.969885150546;6035.064564992434;6053.061775424816;5879.059350503899;5941.37615550361;6069.666168360783;6084.665343406155;6159.476444502267;5913.349531551612;5919.6744179070565;5938.554608404301;6001.5798894077;6025.0661147522205 04:05:23 INFO - PROCESS | 25448 | |1;ext.html;578.7453520451002;604.1843511259799;635.501131611685;648.1768154443854;667.682850645943;45056;46641.30038049428;46787;50105.248421273616;50119.24821127686;46046.309305360446;46189;46545.53454465454;46600.30099548509;46653;8838.381313308071;8925.285977121846;8978.461292322449;8983.10168983103;8997.370184087116;8811.074837142103;8832.8675069874;8858.911410885874;8864.423812452202;8874.378793484459;8866.335024873128;8880.8667869982;8903.287736981058;8942.508162051085;8961;8847.33644976626;8894.377393582452;8894.555272236363;8896.955515222415;8915.821683566292;8797.472151670856;8831.646734130627;8862.955685221532;8882.822343553158;8899.110088991114;43028.139437211394;43056.569434305566;43315.35026974598;43416;43475.56524434778;3656.3966945453967;3794.962050379516;3804.410316400935;3963.207358528306;4424.491183513905;32249.677503225135;32282.51576226335;32484.83757581197;32591.51112733311;32610;4438.267685831834;4482.282834746457;4509.819607215707;4529;4560.543945605446;390526;394035;394701;394920;396325;61826;62022;62117.378826212065;62232;62448.375516244254;56836;56878.14682779762;56965.71517142388;56974;57264.713676432184;17855;18049.909750451425;18180.545486362946;18261.178246978918;18262.90868545649;14608;14695.92652036733;14721.779173312409;14752.18862962526;14788.63028424298;16088.517344479684;16776.916115419346;16791.32834686599;16866.831331686528;16892.324307027582;5953.464188223081;6030.788922387783;6123.96938015316;6167.969160154171;6204.875902481925;985.6698006168014;1036.8341065429495;1053.4258828938248;1079.8056349856945;1092.5848177692426;32341.191470213435;32723;32846;32970.17574560655;33370.8331458346;1131.0612191880718;1150.5225331487507;1226.6136167107334;1235.7899157143306;1238.325112813519;17103;17663.470095897144;18307.54231144232;18978;19029.333973311146;571445;574228;577496;578325;579110;62893.37106628875;62980.685096575144;62993.370066298754;63028.36971630317;63523;1428.757111291083;1458.6902486606425;1459.649684075814;1485.6880055188315;1488.4939120699014;32815.835920820246;32949.67050329466;33378.83310583432;33438.83280583582;33694.49458258177;52852.47147528476;53516.73241633767;53595.19607205817;53601.73199134135;53759.73120134374;491618;493278;494923;496001;497457;30013.249668758457;47968.760156198994;48019.03961920812;48654.75672621614;49257.50742492673;49131.26303105528;49316.75341623269;49705.50294497154;52491;52901.73549132384;43477.56522434735;43559.56440435682;43635.12729745324;45444.54555454535;45647.08705825798;42081.78959105185;42934.78530622009;43338.34992475178;43815.78092109519;44929.10141797081;44865;45405.31892021689;45620.77189614163;45862;45924.770376147906;36561;38611.841644750704;39401.802990986005;39561.80219098886;39704.80147599243;29622.555661665523;29828;29892.4409919329;29898.252543686584;30356 04:05:23 INFO - PROCESS | 25448 | |2;jquery.html;429.9355096735491;431.857330042057;432.5220631202522;436.7052239738177;445.26975759753986;18526.351577694782;19143.521411964706;20231.089600967956;20426.69359959602;20590.279340223096;17731.847429917045;18909.05454727265;19497.41507754766;19640.21439142436;19677.21291148356;5278.1291086970605;5484.067708489546;5518.834434966958;5533.972330138344;5535.861603459925;5273.8945221095555;5394.244805727181;5422.701751403672;5441.918371224435;5448.42791506892;5422.945770542284;5440.755166017539;5459.426760190182;5461.371942226655;5467.043267428204;5207.973960130175;5362.249285100089;5416.943695979286;5430.755615997289;5438.782448702047;5256.316678831766;5268.60485463588;5269.710165940872;5289.0744119779265;5301.522862942354;15142.167180805161;19276.518087047796;24454.877725611437;24681.38296542583;24741.5051698965;2399.3761621978238;2410.8071354291615;2430.9149179778624;2454.006127518358;2454.2882564056404;10954.890451095467;10983.286086404358;11022.889771102267;11062.05972492331;11241.83137252942;1997.3808119483008;2017.8385729141633;2052.568960518293;2090.4982804127053;2110.482931681732;86532.56733716291;86838.5658071712;88957.55521222418;90261.54869225678;90894;11490.88509114898;11629.47667354971;11633.767324653629;11982.940085299517;12092.214006089576;17247.65504689899;17448.5637859052;17474.388396406066;17475.21361538734;17480.21339039746;8988.685396011108;8993;9039.186473217442;9231.399959002643;9285.535723213947;8628.568571571397;8642.395032347675;8702.260307873901;8917.152870477294;8940.642374304955;5146.639735218499;5166.147585648401;5193.792248310101;5244.895102097937;5356.4107948125675;2000.369883486697;2054.2296638760463;2060.2171174953423;2094.204202403077;2126.181420153252;948.3124734567383;957.2772556719632;1017.976933182162;1032.4940779018227;1092.1754075672816;19443.4166974991;20068.39794806158;20845.68731469029;20925.686114707987;20955.26656567013;1033.7105610429091;1058.1481907064733;1073.2809017957986;1074.7474343529263;1095.5684257179569;11246.718832029264;11708.356040417859;11723.296602203895;11755.235909665844;11883.821742673867;535724;544008;571726;586286;590988;91581.5420922891;93922;97714.51142744241;100634.4968275154;100790;512.4875124875125;538.0583978038433;539.900118478075;540.3326891289255;541.8753686652013;11512.424378781196;11943.761124777282;11961.64115076549;12233;12347.13570050088;39898.999999998836;42238.366424503045;42263.366049508666;43456.782716086214;44186;62756.37243627688;63392;63679.36320636734;64143.037854431284;64371.678141608994;9326.300527460604;9556.139947404488;9621.230301575717;9668.419894806335;9739.659111931049;7386.630668466448;10554.78890422172;11373.54505819758;13685.45258189701;13983.720325593227;12014.579489718168;12231.69420764488;12355.135140540435;12369.196002259825;12697.619071427873;11694.590689325832;12013.099017573892;12292.201006934522;12300.630981070582;12334.136610437543;11279;11308.434578271219;12536.059795515555;12737.55418560346;12803;9325.440473571607;9408.623655053994;9573.569189386633;9619.855702164614;9671.081247281498;9793.902060979299;11930.582429614922;12254.938725306316;12392.62822115338;12431.214610415562 04:05:23 INFO - PROCESS | 25448 | |3;mootools.html;1553.262200454784;1557.9143147126906;1745.458907738601;1787.2225581871878;1826.2238548616842;7993.240642138988;8220.095789463154;8547.145285471457;9077.364584479097;9099.681511147111;8130.430869839113;8459.196376344238;8472.830543389144;8603.870941935877;8630.223279904807;2465.790407815338;2490.402303447169;2501.2746303571944;2501.3496490912403;2505.1607711416696;2462.938426539333;2575.163072001598;2575.484903019394;2577.201067669029;2579.290695058855;2473.51766405551;2476.306634142434;2496.2885577610386;2497.1384872219146;2529.2791554407;2437.7805997460223;2442.6702395176603;2452.4849781545895;2460.372604985726;2465.704115506133;2417.528581926525;2459.8032157427365;2474.4308808974038;2486.532945562109;2501.574732295496;9063.13900179482;9073.455592664395;9105.590248438835;9108.954455227682;9125.17873391398;5622.381538030813;5827.912581311284;5830.883382332372;5836.328822185461;5841.415858414167;3562.8040457774814;3580.7314451415987;3645.908852278714;3683.4843121962945;3704.462852886343;1198.233130796291;1205.2828567002618;1237.6225251298351;1265.2661456355384;1269.2765123879392;12636.05229607783;12655.557055503104;12681.175723577939;12761.744765104646;12789.360531973363;4797.952020479751;5083.517065878736;5092.694438333712;5101.566366858859;5196.636235463481;10659.94670026645;10708.357498550113;10730.463476826128;10738.892611073945;10751;5655.660660360391;5669.744861481243;5670.971645141748;5690.118031705092;5707.3721890592005;4439.267520859086;4829.323894654751;4996.750162491933;4999.575036121971;5249.737513124329;4184.4141820145205;4240.5123410808155;4304.375865499485;4342.761148136883;4349.151915376535;1442.3365251983996;1445.0968144909432;1450.0719539494733;1451.7459444597152;1476.6677497562962;959.4051687953513;971.2133172130597;978.5694294510392;990.4997976022063;991.2862738828032;5913.231279933581;5951.732172052268;6091.208142941389;6140.508759299245;6199.380061993855;505.74207154351546;508.8244555628302;513.6507175120954;518.082993102207;518.8028549151373;4175.144095460423;4195.853145139906;4206.305959516645;4226.429432026698;4233.915321693549;10856.945715271531;11081.224314297922;11150.888491115147;11190.888091119148;11196.216264861381;11138.498767555317;11216.831747523795;11224.719382015515;11228.887711122785;11240.100791936626;8129.79675508117;8452.915470845335;8464.280536154496;8493.702720404755;8665.956670216734;6117.724702388492;6154.9996251217635;6280.780172693934;6300.59046161998;6419.325970773001;9606.27952903549;10526.210534210119;10567.365958042543;10568.154547636324;10572.101371383518;10028.147607453448;10200;10201.336913100922;10254;10273.434961077213;7137.1435427749;7615.428842836699;7910.604469776603;7935.920640793749;8006.679732810622;8803.119688031145;8908.55457227123;8969.14793094655;9010.954945225232;9021.774455638662;7719.845603088019;7831.70776821818;7860.528368297921;8016.639251233825;8077.071136819341;7816.804579885321;7841.411894108079;7848.7645370638975;7943.682252709827;8151.30713889326;7141.750038748619;7185.461090418135;7211.350978411968;7213;7216.061911951413;4704.435467743892;4715.952840471551;4794.520547945178;4898;4966.106100901728;5007.5486928056425;5066.113430149635;5133.332666753298;5171.560417364566;5183.041137389595 04:05:23 INFO - PROCESS | 25448 | |4;prototype.html;356.48665921073655;362.05503635511326;364.42420974859715;364.9215418684982;365.533944221118;5661.4338566143415;5686;5735.369109397968;5764.769409223636;5779.942200577993;5521.4478552144765;5621.578381621374;5622.746976386063;5635.3237611486575;5687.6303040302355;4388.23205938961;4442.2004039272915;4446.199289287827;4447.930143918311;4464.151811155886;4445.51099379068;4446.555344465543;4447.866564003069;4474.955250447487;4482.551744825508;4432.15789000089;4442.577955094261;4454.020115574568;4457.175422546823;4495.617872480843;4404.801783919731;4438.622717069053;4445.955540444586;4457.130859482386;4473.776311184428;3981.5222173339384;4000.859754969849;4004.3192657248337;4005.1589166274825;4007.6393124618926;5487.64330318528;5498.532624726903;5506.779728810843;5547.3343198816;5576.442355764431;4980.402351717781;4992.925106123411;5091.414487333967;5118.513741194618;5142.7685754140775;5893.58744887858;5909.261342332208;5943.227380440559;5954.732037058343;5961.731722072517;4423;4453.844115455976;4456;4465.531119232466;4476.194285028693;5860.765569377219;5938.7624495020145;6057.757689692407;6130.693465326761;6149.477294429934;4357.716748411343;4373.431453910971;4374.19077470669;4383.780810959439;4395.63735242076;4420.270655341897;4451.399061126771;4473.6868419211;4474.932876006863;4476.686631935799;4936.605071594264;4982.153033984231;5086.694798312039;5096.898062038738;5117.283580298761;5901.734421951022;5907.881842363128;5909.172715819789;5920.792772253037;5926.496247818984;1478.7264356094156;1489.121418363171;1491.261825396414;1491.4108926973784;1496.7006598680307;995.3729150635054;1034.4414016431194;1043.5721354244874;1052.1372474570778;1055.4775386183887;5617.792174682381;5628.634138780966;5651.2935883014625;5691.77232910679;5713.942860571424;5910;5959.7914073008105;5960.403959604005;5979.372165922602;6037.969810150921;5299;5567.638103523258;5574.777008919679;5611.9593892398225;5660.433956604306;3121.4849549824025;3148.3860647173583;3186.091963790355;3206.0061380971506;3216.726578240829;5837.620554663933;6035.215421995113;6114;6289.779857704958;6299.968500157562;5946.554008449383;5969.313528944227;5991.400859914061;6027.6684782336515;6040.184575082396;6112.388761123852;6181.876362472815;6184.855801676704;6221.47117495018;6238.344973777779;5724.942750572441;5755.7122143893475;5783.240893419311;5807.912881306868;5809.62237454581;5769.53843692512;5771.422857714195;5852.824415267549;5889.293284805679;5894.585299528168;6095.2685677718955;6168.691565421801;6220.315765265907;6224.439800417984;6278.560500764903;4362.825486980612;4389.714668546534;4390.912181756283;4401.933970990373;4434.778261086997;5822.76708931655;6075.210222671025;6134.969325153345;6154.692265386802;6179.721912513858;5965.463108320272;5989.8203053908455;5991.940080599138;5996.44092535935;6000.609960352563;6006.939930600638;6024.3674414187635;6025.523746682091;6054.152418661303;6072.483838873745;5643.915341269966;5912;5925.911111333419;5972.34304226526;5999.640021598718;6068.177048459443;6088.817335479943;6106.6336019838955;6126.693665316806;6152.200213972155;5594.664320140804;5854.765809367577;5867.5305975521005;5910.822675319747;5991.670458124845 04:05:23 INFO - PROCESS | 25448 | |5;yui.html;700.08289141225;704.6828926982859;712.1596516110989;735.2794261623612;752.6913965274239;14224.075435096724;15020.624484387896;15035.09789412636;15064.698706025873;15094.924525377386;14041.719165616681;14299.571012869605;14366.138031718105;14420.855791442109;14482.203478808688;701.5720410549561;712.9287071292881;807.6284908941865;825.4180802534199;839.6851180807182;840.8318336332758;846.8687353460224;848.1391387741447;848.749618862434;850.2475309351238;892.2415946445534;894.0433735902587;894.6153154143716;895.6820328783285;897.1253028297391;886.2555453419127;886.3972498700913;886.5567216391804;888.4580405952364;889.4396530185974;652.5530011941835;655.5968079630993;656.7701304543372;657.0144782825762;657.81252343082;13977.23125228112;14035.719285614332;14081.577552673436;14146.504872329419;14969.700605987928;13972.51096211638;14552.854471455255;14676.486322978644;14729.558113256513;14805;12089.637310880687;12144.757104857854;12153.331566763825;12209.572664956773;12356.135070545066;3697.759645623026;3706.2772759311947;3741.9251614967548;3789.621037896216;3790.4124860646366;64441.67779161074;65332.67333663349;66630;67211;68699.65650171717;10327.638532651321;10665.253432259822;10852.294600850919;11089.534848982736;11341;20015.299464518674;20159.8992005042;20312.492187695425;20320.69518957217;20360.69458958117;8002.559859207683;8071.394645401619;8075.273225409741;8131.064927533291;8368.37237207212;4585.656075794329;4634.791434385461;4637.582617564435;4704.341392205094;4772.570468657837;3324.7173990210617;3430.142464383904;3430.2453460238708;3433.073070271013;3821.159344944108;722.9674664640104;724.5580196080386;728.457299312016;728.5337384074197;735.3308489274734;695.2074634916199;730.7442395161758;772.4515593928262;782.6126067596463;815.3517953227199;9053.864192037125;9141.588628511732;9142.314326425545;9342.719718408458;9617.615295388106;588.3057991569989;612.1919066831739;659.475716805141;684.8459096703301;696.9686364113627;4567.200739870509;4774.092922344744;4841.491643377465;4847.75761211938;4878.560929516289;70998.64500677463;75398.62300688462;94386;95948.52025739827;96683.51658241663;47312.526874730815;71983;72746.63626681939;74127.62936185284;74358.6282068597;56925;67330.32669673339;69788.30211697919;70226.64886675533;71248.99999999897;10026.947170546988;10344.793104138025;10384.532696028546;10398.480075996322;10521.631742888962;32936;33185.83407082949;37023.62976370202;40550.1889962205;41987;22717.659235111816;24347.75652243455;39904;50412.747936260086;59887.70056149692;13207.801882971571;13285.734285314433;13491.595252142451;13587.524436645066;13612.93193534026;13912.165270083828;14056.508022219174;14499.85500144985;15104.622384440478;15286.847131528988;12882;13138.540151094665;13346.532871349456;13424.93287533556;14145;13317.66705832362;13866.930665346608;13984.790228146383;14108.576742697325;14337.283135843374;13998.300084995506;14079.718405632035;14111.435542578181;14141.434342626591;14195.722384985402;9872.901270987199;10581.52383142745;11702.70743231426;11741.412929353328;11928.165028447926;11315;11447.51182346323;11624.767504650028;11720.179587429138;11757.882421175678 04:05:23 INFO - PROCESS | 25448 | __end_tp_report 04:05:23 INFO - PROCESS | 25448 | __start_cc_report 04:05:23 INFO - PROCESS | 25448 | _x_x_mozilla_cycle_collect,318 04:05:23 INFO - PROCESS | 25448 | __end_cc_report 04:05:23 INFO - PROCESS | 25448 | __startTimestamp1480593923107__endTimestamp 04:05:23 INFO - PROCESS | 25448 | 04:05:23 INFO - PROCESS | 25448 | ------- Summary: start ------- 04:05:23 INFO - PROCESS | 25448 | Number of tests: 6 04:05:23 INFO - PROCESS | 25448 | 04:05:23 INFO - PROCESS | 25448 | [#0] dojo.html Cycles:165 Average:5755.36 Median:5961.46 stddev:656.82 (11.0%) stddev-sans-first:628.66 04:05:23 INFO - PROCESS | 25448 | Values: 3246.6 3271.0 3276.7 3292.6 3295.9 5731.7 5798.6 5801.8 5802.4 5803.5 5796.0 5843.0 5845.8 5851.2 5867.9 5269.8 5294.9 5315.4 5337.1 5351.5 5322.0 5348.0 5351.9 5355.5 5382.5 5108.7 5121.8 5314.7 5333.6 5334.2 5177.6 5227.9 5245.9 5271.8 5324.9 5253.7 5253.9 5268.7 5275.2 5345.1 5793.0 5841.7 5848.8 5892.1 5899.0 6089.9 6103.1 6142.2 6157.5 6204.6 6189.8 6199.6 6216.2 6221.4 6224.7 5701.4 5750.8 5781.4 5808.7 5822.1 6190.9 6209.9 6249.5 6249.8 6250.8 6065.5 6071.5 6072.1 6081.2 6108.7 6127.8 6165.3 6167.7 6168.2 6169.4 5884.1 5937.6 6059.2 6070.6 6097.5 6187.0 6192.5 6200.1 6202.5 6228.2 4750.7 4758.5 4763.5 4766.4 4787.3 4146.0 4151.6 4207.5 4256.1 4287.5 5849.6 5861.5 5885.3 5888.2 5945.3 5986.6 6140.5 6168.9 6183.1 6191.9 5778.9 5868.5 5945.5 5961.5 5997.6 5325.5 5354.4 5357.1 5360.9 5402.0 6467.1 6483.9 6502.5 6504.7 6506.4 6220.1 6256.2 6263.9 6273.3 6274.0 6096.9 6218.1 6278.0 6444.1 6476.1 6191.7 6201.3 6206.3 6208.4 6212.8 6286.8 6297.8 6299.2 6303.6 6335.6 5788.4 5892.9 6010.9 6136.6 6144.1 6030.3 6096.1 6119.5 6128.1 6133.0 5968.5 5999.5 6023.0 6035.1 6053.1 5879.1 5941.4 6069.7 6084.7 6159.5 5913.3 5919.7 5938.6 6001.6 6025.1 04:05:23 INFO - PROCESS | 25448 | 04:05:23 INFO - PROCESS | 25448 | [#1] ext.html Cycles:180 Average:65695.35 Median:25002.54 stddev:131029.66 (524.1%) stddev-sans-first:131306.02 04:05:23 INFO - PROCESS | 25448 | Values: 578.7 604.2 635.5 648.2 667.7 45056.0 46641.3 46787.0 50105.2 50119.2 46046.3 46189.0 46545.5 46600.3 46653.0 8838.4 8925.3 8978.5 8983.1 8997.4 8811.1 8832.9 8858.9 8864.4 8874.4 8866.3 8880.9 8903.3 8942.5 8961.0 8847.3 8894.4 8894.6 8897.0 8915.8 8797.5 8831.6 8863.0 8882.8 8899.1 43028.1 43056.6 43315.4 43416.0 43475.6 3656.4 3795.0 3804.4 3963.2 4424.5 32249.7 32282.5 32484.8 32591.5 32610.0 4438.3 4482.3 4509.8 4529.0 4560.5 390526.0 394035.0 394701.0 394920.0 396325.0 61826.0 62022.0 62117.4 62232.0 62448.4 56836.0 56878.1 56965.7 56974.0 57264.7 17855.0 18049.9 18180.5 18261.2 18262.9 14608.0 14695.9 14721.8 14752.2 14788.6 16088.5 16776.9 16791.3 16866.8 16892.3 5953.5 6030.8 6124.0 6168.0 6204.9 985.7 1036.8 1053.4 1079.8 1092.6 32341.2 32723.0 32846.0 32970.2 33370.8 1131.1 1150.5 1226.6 1235.8 1238.3 17103.0 17663.5 18307.5 18978.0 19029.3 571445.0 574228.0 577496.0 578325.0 579110.0 62893.4 62980.7 62993.4 63028.4 63523.0 1428.8 1458.7 1459.6 1485.7 1488.5 32815.8 32949.7 33378.8 33438.8 33694.5 52852.5 53516.7 53595.2 53601.7 53759.7 491618.0 493278.0 494923.0 496001.0 497457.0 30013.2 47968.8 48019.0 48654.8 49257.5 49131.3 49316.8 49705.5 52491.0 52901.7 43477.6 43559.6 43635.1 45444.5 45647.1 42081.8 42934.8 43338.3 43815.8 44929.1 44865.0 45405.3 45620.8 45862.0 45924.8 36561.0 38611.8 39401.8 39561.8 39704.8 29622.6 29828.0 29892.4 29898.3 30356.0 04:05:23 INFO - PROCESS | 25448 | 04:05:23 INFO - PROCESS | 25448 | [#2] jquery.html Cycles:180 Average:31690.23 Median:13567.84 stddev:93249.89 (687.3%) stddev-sans-first:93481.93 04:05:23 INFO - PROCESS | 25448 | Values: 429.9 431.9 432.5 436.7 445.3 18526.4 19143.5 20231.1 20426.7 20590.3 17731.8 18909.1 19497.4 19640.2 19677.2 5278.1 5484.1 5518.8 5534.0 5535.9 5273.9 5394.2 5422.7 5441.9 5448.4 5422.9 5440.8 5459.4 5461.4 5467.0 5208.0 5362.2 5416.9 5430.8 5438.8 5256.3 5268.6 5269.7 5289.1 5301.5 15142.2 19276.5 24454.9 24681.4 24741.5 2399.4 2410.8 2430.9 2454.0 2454.3 10954.9 10983.3 11022.9 11062.1 11241.8 1997.4 2017.8 2052.6 2090.5 2110.5 86532.6 86838.6 88957.6 90261.5 90894.0 11490.9 11629.5 11633.8 11982.9 12092.2 17247.7 17448.6 17474.4 17475.2 17480.2 8988.7 8993.0 9039.2 9231.4 9285.5 8628.6 8642.4 8702.3 8917.2 8940.6 5146.6 5166.1 5193.8 5244.9 5356.4 2000.4 2054.2 2060.2 2094.2 2126.2 948.3 957.3 1018.0 1032.5 1092.2 19443.4 20068.4 20845.7 20925.7 20955.3 1033.7 1058.1 1073.3 1074.7 1095.6 11246.7 11708.4 11723.3 11755.2 11883.8 535724.0 544008.0 571726.0 586286.0 590988.0 91581.5 93922.0 97714.5 100634.5 100790.0 512.5 538.1 539.9 540.3 541.9 11512.4 11943.8 11961.6 12233.0 12347.1 39899.0 42238.4 42263.4 43456.8 44186.0 62756.4 63392.0 63679.4 64143.0 64371.7 9326.3 9556.1 9621.2 9668.4 9739.7 7386.6 10554.8 11373.5 13685.5 13983.7 12014.6 12231.7 12355.1 12369.2 12697.6 11694.6 12013.1 12292.2 12300.6 12334.1 11279.0 11308.4 12536.1 12737.6 12803.0 9325.4 9408.6 9573.6 9619.9 9671.1 9793.9 11930.6 12254.9 12392.6 12431.2 04:05:23 INFO - PROCESS | 25448 | 04:05:23 INFO - PROCESS | 25448 | [#3] mootools.html Cycles:180 Average:5963.37 Median:4932.05 stddev:3348.10 (67.9%) stddev-sans-first:3341.09 04:05:23 INFO - PROCESS | 25448 | Values: 1553.3 1557.9 1745.5 1787.2 1826.2 7993.2 8220.1 8547.1 9077.4 9099.7 8130.4 8459.2 8472.8 8603.9 8630.2 2465.8 2490.4 2501.3 2501.3 2505.2 2462.9 2575.2 2575.5 2577.2 2579.3 2473.5 2476.3 2496.3 2497.1 2529.3 2437.8 2442.7 2452.5 2460.4 2465.7 2417.5 2459.8 2474.4 2486.5 2501.6 9063.1 9073.5 9105.6 9109.0 9125.2 5622.4 5827.9 5830.9 5836.3 5841.4 3562.8 3580.7 3645.9 3683.5 3704.5 1198.2 1205.3 1237.6 1265.3 1269.3 12636.1 12655.6 12681.2 12761.7 12789.4 4798.0 5083.5 5092.7 5101.6 5196.6 10659.9 10708.4 10730.5 10738.9 10751.0 5655.7 5669.7 5671.0 5690.1 5707.4 4439.3 4829.3 4996.8 4999.6 5249.7 4184.4 4240.5 4304.4 4342.8 4349.2 1442.3 1445.1 1450.1 1451.7 1476.7 959.4 971.2 978.6 990.5 991.3 5913.2 5951.7 6091.2 6140.5 6199.4 505.7 508.8 513.7 518.1 518.8 4175.1 4195.9 4206.3 4226.4 4233.9 10856.9 11081.2 11150.9 11190.9 11196.2 11138.5 11216.8 11224.7 11228.9 11240.1 8129.8 8452.9 8464.3 8493.7 8666.0 6117.7 6155.0 6280.8 6300.6 6419.3 9606.3 10526.2 10567.4 10568.2 10572.1 10028.1 10200.0 10201.3 10254.0 10273.4 7137.1 7615.4 7910.6 7935.9 8006.7 8803.1 8908.6 8969.1 9011.0 9021.8 7719.8 7831.7 7860.5 8016.6 8077.1 7816.8 7841.4 7848.8 7943.7 8151.3 7141.8 7185.5 7211.4 7213.0 7216.1 4704.4 4716.0 4794.5 4898.0 4966.1 5007.5 5066.1 5133.3 5171.6 5183.0 04:05:23 INFO - PROCESS | 25448 | 04:05:23 INFO - PROCESS | 25448 | [#4] prototype.html Cycles:180 Average:4989.45 Median:5647.60 stddev:1442.60 (25.5%) stddev-sans-first:1404.11 04:05:23 INFO - PROCESS | 25448 | Values: 356.5 362.1 364.4 364.9 365.5 5661.4 5686.0 5735.4 5764.8 5779.9 5521.4 5621.6 5622.7 5635.3 5687.6 4388.2 4442.2 4446.2 4447.9 4464.2 4445.5 4446.6 4447.9 4475.0 4482.6 4432.2 4442.6 4454.0 4457.2 4495.6 4404.8 4438.6 4446.0 4457.1 4473.8 3981.5 4000.9 4004.3 4005.2 4007.6 5487.6 5498.5 5506.8 5547.3 5576.4 4980.4 4992.9 5091.4 5118.5 5142.8 5893.6 5909.3 5943.2 5954.7 5961.7 4423.0 4453.8 4456.0 4465.5 4476.2 5860.8 5938.8 6057.8 6130.7 6149.5 4357.7 4373.4 4374.2 4383.8 4395.6 4420.3 4451.4 4473.7 4474.9 4476.7 4936.6 4982.2 5086.7 5096.9 5117.3 5901.7 5907.9 5909.2 5920.8 5926.5 1478.7 1489.1 1491.3 1491.4 1496.7 995.4 1034.4 1043.6 1052.1 1055.5 5617.8 5628.6 5651.3 5691.8 5713.9 5910.0 5959.8 5960.4 5979.4 6038.0 5299.0 5567.6 5574.8 5612.0 5660.4 3121.5 3148.4 3186.1 3206.0 3216.7 5837.6 6035.2 6114.0 6289.8 6300.0 5946.6 5969.3 5991.4 6027.7 6040.2 6112.4 6181.9 6184.9 6221.5 6238.3 5724.9 5755.7 5783.2 5807.9 5809.6 5769.5 5771.4 5852.8 5889.3 5894.6 6095.3 6168.7 6220.3 6224.4 6278.6 4362.8 4389.7 4390.9 4401.9 4434.8 5822.8 6075.2 6135.0 6154.7 6179.7 5965.5 5989.8 5991.9 5996.4 6000.6 6006.9 6024.4 6025.5 6054.2 6072.5 5643.9 5912.0 5925.9 5972.3 5999.6 6068.2 6088.8 6106.6 6126.7 6152.2 5594.7 5854.8 5867.5 5910.8 5991.7 04:05:23 INFO - PROCESS | 25448 | 04:05:23 INFO - PROCESS | 25448 | [#5] yui.html Cycles:180 Average:16936.50 Median:41268.59 stddev:21947.49 (53.2%) stddev-sans-first:21975.19 04:05:23 INFO - PROCESS | 25448 | Values: 700.1 704.7 712.2 735.3 752.7 14224.1 15020.6 15035.1 15064.7 15094.9 14041.7 14299.6 14366.1 14420.9 14482.2 701.6 712.9 807.6 825.4 839.7 840.8 846.9 848.1 848.7 850.2 892.2 894.0 894.6 895.7 897.1 886.3 886.4 886.6 888.5 889.4 652.6 655.6 656.8 657.0 657.8 13977.2 14035.7 14081.6 14146.5 14969.7 13972.5 14552.9 14676.5 14729.6 14805.0 12089.6 12144.8 12153.3 12209.6 12356.1 3697.8 3706.3 3741.9 3789.6 3790.4 64441.7 65332.7 66630.0 67211.0 68699.7 10327.6 10665.3 10852.3 11089.5 11341.0 20015.3 20159.9 20312.5 20320.7 20360.7 8002.6 8071.4 8075.3 8131.1 8368.4 4585.7 4634.8 4637.6 4704.3 4772.6 3324.7 3430.1 3430.2 3433.1 3821.2 723.0 724.6 728.5 728.5 735.3 695.2 730.7 772.5 782.6 815.4 9053.9 9141.6 9142.3 9342.7 9617.6 588.3 612.2 659.5 684.8 697.0 4567.2 4774.1 4841.5 4847.8 4878.6 70998.6 75398.6 94386.0 95948.5 96683.5 47312.5 71983.0 72746.6 74127.6 74358.6 56925.0 67330.3 69788.3 70226.6 71249.0 10026.9 10344.8 10384.5 10398.5 10521.6 32936.0 33185.8 37023.6 40550.2 41987.0 22717.7 24347.8 39904.0 50412.7 59887.7 13207.8 13285.7 13491.6 13587.5 13612.9 13912.2 14056.5 14499.9 15104.6 15286.8 12882.0 13138.5 13346.5 13424.9 14145.0 13317.7 13866.9 13984.8 14108.6 14337.3 13998.3 14079.7 14111.4 14141.4 14195.7 9872.9 10581.5 11702.7 11741.4 11928.2 11315.0 11447.5 11624.8 11720.2 11757.9 04:05:23 INFO - PROCESS | 25448 | -------- Summary: end -------- 04:05:23 INFO - PROCESS | 25448 | 04:05:23 INFO - TEST-INFO | 25448: exit 0 04:05:23 INFO - TEST-OK | dromaeo_css | took 1112717ms 04:05:23 INFO - TEST-START | kraken 04:05:23 INFO - operating with platform_type : linux_ 04:05:23 INFO - Initialising browser for kraken test... 04:05:23 INFO - TEST-INFO | started process 25825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprzZngb/profile http://localhost:40689/getInfo.html) 04:05:27 INFO - PROCESS | 25825 | __metrics Screen width/height:1600/1200 04:05:27 INFO - PROCESS | 25825 | colorDepth:24 04:05:27 INFO - PROCESS | 25825 | Browser inner width/height: 1024/697 04:05:27 INFO - PROCESS | 25825 | __metrics 04:05:28 ERROR - PROCESS | 25825 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 04:05:29 INFO - TEST-INFO | 25825: exit 0 04:05:29 INFO - Browser initialized. 04:05:29 INFO - Running cycle 1/1 for kraken test... 04:05:29 INFO - TEST-INFO | started process 25959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprzZngb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:05:41 INFO - PROCESS | 25959 | RSS: Main: 151707648 04:05:41 INFO - PROCESS | 25959 | 04:05:43 INFO - PROCESS | 25959 | Cycle 1(1): loaded http://localhost:40689/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40689/tests/kraken/driver.html?testName=audio-beat-detection) 04:05:44 INFO - PROCESS | 25959 | RSS: Main: 156733440 04:05:44 INFO - PROCESS | 25959 | 04:05:47 INFO - PROCESS | 25959 | Cycle 1(1): loaded http://localhost:40689/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40689/tests/kraken/driver.html?testName=audio-dft) 04:05:47 INFO - PROCESS | 25959 | RSS: Main: 154615808 04:05:47 INFO - PROCESS | 25959 | 04:05:50 INFO - PROCESS | 25959 | Cycle 1(1): loaded http://localhost:40689/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40689/tests/kraken/driver.html?testName=audio-fft) 04:05:51 INFO - PROCESS | 25959 | RSS: Main: 155185152 04:05:51 INFO - PROCESS | 25959 | 04:05:53 INFO - PROCESS | 25959 | Cycle 1(1): loaded http://localhost:40689/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40689/tests/kraken/driver.html?testName=audio-oscillator) 04:05:53 INFO - PROCESS | 25959 | RSS: Main: 154898432 04:05:53 INFO - PROCESS | 25959 | 04:05:55 INFO - PROCESS | 25959 | Cycle 1(1): loaded http://localhost:40689/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40689/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:05:56 INFO - PROCESS | 25959 | RSS: Main: 155164672 04:05:56 INFO - PROCESS | 25959 | 04:05:59 INFO - PROCESS | 25959 | Cycle 1(1): loaded http://localhost:40689/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40689/tests/kraken/driver.html?testName=imaging-darkroom) 04:06:00 INFO - PROCESS | 25959 | RSS: Main: 158720000 04:06:00 INFO - PROCESS | 25959 | 04:06:03 INFO - PROCESS | 25959 | Cycle 1(1): loaded http://localhost:40689/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40689/tests/kraken/driver.html?testName=imaging-desaturate) 04:06:04 INFO - PROCESS | 25959 | RSS: Main: 158609408 04:06:04 INFO - PROCESS | 25959 | 04:06:06 INFO - PROCESS | 25959 | Cycle 1(1): loaded http://localhost:40689/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40689/tests/kraken/driver.html?testName=json-parse-financial) 04:06:07 INFO - PROCESS | 25959 | RSS: Main: 158601216 04:06:07 INFO - PROCESS | 25959 | 04:06:08 INFO - PROCESS | 25959 | Cycle 1(1): loaded http://localhost:40689/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40689/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:06:09 INFO - PROCESS | 25959 | RSS: Main: 157474816 04:06:09 INFO - PROCESS | 25959 | 04:06:11 INFO - PROCESS | 25959 | Cycle 1(1): loaded http://localhost:40689/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40689/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:06:11 INFO - PROCESS | 25959 | RSS: Main: 157126656 04:06:11 INFO - PROCESS | 25959 | 04:06:13 INFO - PROCESS | 25959 | Cycle 1(1): loaded http://localhost:40689/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40689/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:06:14 INFO - PROCESS | 25959 | RSS: Main: 157442048 04:06:14 INFO - PROCESS | 25959 | 04:06:17 INFO - PROCESS | 25959 | Cycle 1(1): loaded http://localhost:40689/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:06:17 INFO - PROCESS | 25959 | RSS: Main: 157609984 04:06:17 INFO - PROCESS | 25959 | 04:06:20 INFO - PROCESS | 25959 | Cycle 1(1): loaded http://localhost:40689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:06:21 INFO - PROCESS | 25959 | RSS: Main: 157777920 04:06:21 INFO - PROCESS | 25959 | 04:06:22 INFO - PROCESS | 25959 | Cycle 1(1): loaded http://localhost:40689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40689/tests/kraken/driver.html?testName=ai-astar) 04:06:23 INFO - PROCESS | 25959 | RSS: Main: 159580160 04:06:23 INFO - PROCESS | 25959 | 04:06:23 INFO - PROCESS | 25959 | __start_tp_report 04:06:23 INFO - PROCESS | 25959 | _x_x_mozilla_page_load 04:06:23 INFO - PROCESS | 25959 | _x_x_mozilla_page_load_details 04:06:23 INFO - PROCESS | 25959 | |i|pagename|runs| 04:06:23 INFO - PROCESS | 25959 | |0;ai-astar;102;111;111;113;111;111;112;110;110;110 04:06:23 INFO - PROCESS | 25959 | |1;audio-beat-detection;149;125;123;157;124;122;124;129;149;122 04:06:23 INFO - PROCESS | 25959 | |2;audio-dft;167;162;163;162;161;162;161;163;162;162 04:06:23 INFO - PROCESS | 25959 | |3;audio-fft;78;76;74;106;75;76;75;75;105;74 04:06:23 INFO - PROCESS | 25959 | |4;audio-oscillator;82;81;107;82;82;82;100;81;82;99 04:06:23 INFO - PROCESS | 25959 | |5;imaging-gaussian-blur;118;118;117;117;118;120;117;117;117;117 04:06:23 INFO - PROCESS | 25959 | |6;imaging-darkroom;146;147;147;147;148;148;149;149;147;148 04:06:23 INFO - PROCESS | 25959 | |7;imaging-desaturate;85;85;85;85;87;85;84;84;85;85 04:06:23 INFO - PROCESS | 25959 | |8;json-parse-financial;50;49;50;49;51;50;51;51;50;50 04:06:23 INFO - PROCESS | 25959 | |9;json-stringify-tinderbox;60;60;58;60;60;60;59;59;59;61 04:06:23 INFO - PROCESS | 25959 | |10;stanford-crypto-aes;75;77;79;82;76;78;75;76;83;76 04:06:23 INFO - PROCESS | 25959 | |11;stanford-crypto-ccm;128;127;130;128;127;146;132;137;172;127 04:06:23 INFO - PROCESS | 25959 | |12;stanford-crypto-pbkdf2;155;158;159;162;153;153;154;152;153;154 04:06:23 INFO - PROCESS | 25959 | |13;stanford-crypto-sha256-iterative;65;63;62;63;64;63;66;64;62;62 04:06:23 INFO - PROCESS | 25959 | __end_tp_report 04:06:23 INFO - PROCESS | 25959 | __start_cc_report 04:06:23 INFO - PROCESS | 25959 | _x_x_mozilla_cycle_collect,818 04:06:23 INFO - PROCESS | 25959 | __end_cc_report 04:06:23 INFO - PROCESS | 25959 | __startTimestamp1480593983084__endTimestamp 04:06:23 INFO - PROCESS | 25959 | 04:06:23 INFO - PROCESS | 25959 | ------- Summary: start ------- 04:06:23 INFO - PROCESS | 25959 | Number of tests: 14 04:06:23 INFO - PROCESS | 25959 | 04:06:23 INFO - PROCESS | 25959 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:3.00 (2.7%) stddev-sans-first:1.00 04:06:23 INFO - PROCESS | 25959 | Values: 102.0 111.0 111.0 113.0 111.0 111.0 112.0 110.0 110.0 110.0 04:06:23 INFO - PROCESS | 25959 | 04:06:23 INFO - PROCESS | 25959 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:127.00 stddev:13.62 (10.7%) stddev-sans-first:13.05 04:06:23 INFO - PROCESS | 25959 | Values: 149.0 125.0 123.0 157.0 124.0 122.0 124.0 129.0 149.0 122.0 04:06:23 INFO - PROCESS | 25959 | 04:06:23 INFO - PROCESS | 25959 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:1.72 (1.1%) stddev-sans-first:0.71 04:06:23 INFO - PROCESS | 25959 | Values: 167.0 162.0 163.0 162.0 161.0 162.0 161.0 163.0 162.0 162.0 04:06:23 INFO - PROCESS | 25959 | 04:06:23 INFO - PROCESS | 25959 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:12.76 (17.0%) stddev-sans-first:13.47 04:06:23 INFO - PROCESS | 25959 | Values: 78.0 76.0 74.0 106.0 75.0 76.0 75.0 75.0 105.0 74.0 04:06:23 INFO - PROCESS | 25959 | 04:06:23 INFO - PROCESS | 25959 | [#4] audio-oscillator Cycles:10 Average:87.80 Median:82.00 stddev:10.02 (12.2%) stddev-sans-first:10.41 04:06:23 INFO - PROCESS | 25959 | Values: 82.0 81.0 107.0 82.0 82.0 82.0 100.0 81.0 82.0 99.0 04:06:23 INFO - PROCESS | 25959 | 04:06:23 INFO - PROCESS | 25959 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.97 (0.8%) stddev-sans-first:1.01 04:06:23 INFO - PROCESS | 25959 | Values: 118.0 118.0 117.0 117.0 118.0 120.0 117.0 117.0 117.0 117.0 04:06:23 INFO - PROCESS | 25959 | 04:06:23 INFO - PROCESS | 25959 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:0.83 04:06:23 INFO - PROCESS | 25959 | Values: 146.0 147.0 147.0 147.0 148.0 148.0 149.0 149.0 147.0 148.0 04:06:23 INFO - PROCESS | 25959 | 04:06:23 INFO - PROCESS | 25959 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 04:06:23 INFO - PROCESS | 25959 | Values: 85.0 85.0 85.0 85.0 87.0 85.0 84.0 84.0 85.0 85.0 04:06:23 INFO - PROCESS | 25959 | 04:06:23 INFO - PROCESS | 25959 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:50.00 stddev:0.74 (1.5%) stddev-sans-first:0.78 04:06:23 INFO - PROCESS | 25959 | Values: 50.0 49.0 50.0 49.0 51.0 50.0 51.0 51.0 50.0 50.0 04:06:23 INFO - PROCESS | 25959 | 04:06:23 INFO - PROCESS | 25959 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.84 (1.4%) stddev-sans-first:0.88 04:06:23 INFO - PROCESS | 25959 | Values: 60.0 60.0 58.0 60.0 60.0 60.0 59.0 59.0 59.0 61.0 04:06:23 INFO - PROCESS | 25959 | 04:06:23 INFO - PROCESS | 25959 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:77.50 stddev:2.83 (3.7%) stddev-sans-first:2.83 04:06:23 INFO - PROCESS | 25959 | Values: 75.0 77.0 79.0 82.0 76.0 78.0 75.0 76.0 83.0 76.0 04:06:23 INFO - PROCESS | 25959 | 04:06:23 INFO - PROCESS | 25959 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:131.00 stddev:14.21 (10.8%) stddev-sans-first:14.81 04:06:23 INFO - PROCESS | 25959 | Values: 128.0 127.0 130.0 128.0 127.0 146.0 132.0 137.0 172.0 127.0 04:06:23 INFO - PROCESS | 25959 | 04:06:23 INFO - PROCESS | 25959 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.30 Median:154.50 stddev:3.27 (2.1%) stddev-sans-first:3.46 04:06:23 INFO - PROCESS | 25959 | Values: 155.0 158.0 159.0 162.0 153.0 153.0 154.0 152.0 153.0 154.0 04:06:23 INFO - PROCESS | 25959 | 04:06:23 INFO - PROCESS | 25959 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:1.35 (2.1%) stddev-sans-first:1.30 04:06:23 INFO - PROCESS | 25959 | Values: 65.0 63.0 62.0 63.0 64.0 63.0 66.0 64.0 62.0 62.0 04:06:23 INFO - PROCESS | 25959 | -------- Summary: end -------- 04:06:23 INFO - PROCESS | 25959 | 04:06:24 INFO - TEST-INFO | 25959: exit 0 04:06:24 INFO - TEST-OK | kraken | took 60223ms 04:06:24 INFO - SUITE-END | took 1172s 04:06:24 INFO - Completed test suite (00:19:33) 04:06:24 INFO - javascript benchmark 04:06:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7472.258125229272, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3246.594175728034, 3270.9836450817743, 3276.6723327667223, 3292.6378098409177, 3295.8516866740993, 5731.684757338345, 5798.6230894991795, 5801.82594522164, 5802.448767367098, 5803.477687008169, 5795.971020144893, 5843.035899076647, 5845.7953971611005, 5851.239338885949, 5867.853303667411, 5269.76286067127, 5294.867628309304, 5315.415304316522, 5337.06601344765, 5351.491608297206, 5321.973390133044, 5348.0, 5351.892962140755, 5355.491228333302, 5382.515573598375, 5108.748356652607, 5121.820736274231, 5314.734263286839, 5333.57331413486, 5334.1732031535175, 5177.58579313654, 5227.921581176304, 5245.895082098336, 5271.841844744664, 5324.92012619811, 5253.684778913277, 5253.9474605253845, 5268.736563171864, 5275.182346736262, 5345.091334473149, 5792.9710351447975, 5841.7371218295275, 5848.795292164797, 5892.116182572606, 5899.0, 6089.908651370233, 6103.05402662588, 6142.232220972379, 6157.507399408037, 6204.5967012144065, 6189.752409903598, 6199.566030377875, 6216.160818289518, 6221.440070393686, 6224.657643829588, 5701.372848986608, 5750.769969201268, 5781.392953739839, 5808.651480911159, 5822.0684690449325, 6190.907136392958, 6209.875802483925, 6249.468795152463, 6249.78125765596, 6250.812475625738, 6065.54508411862, 6071.453569178795, 6072.089186621954, 6081.179040829431, 6108.664023478663, 6127.816165515042, 6165.290991536031, 6167.660778657128, 6168.167297414881, 6169.444749972435, 5884.08796636522, 5937.614055086406, 6059.151718759377, 6070.6357618543025, 6097.512199024068, 6187.0, 6192.473639740672, 6200.131981522591, 6202.534809889276, 6228.190335256388, 4750.714957102585, 4758.476567577563, 4763.523647635278, 4766.428028636586, 4787.257975013878, 4146.0, 4151.605597468236, 4207.537170911197, 4256.106217694257, 4287.528371879091, 5849.61977471463, 5861.501772349398, 5885.264341957255, 5888.175655408247, 5945.346011938684, 5986.610870293504, 6140.539459540552, 6168.938310616926, 6183.103449999725, 6191.907121393183, 5778.913316300259, 5868.530517558671, 5945.524358051345, 5961.463468287875, 5997.55018373615, 5325.4674532547215, 5354.3574771027725, 5357.142857142916, 5360.892782144335, 5402.027635025733, 6467.062275970052, 6483.935160648333, 6502.479801615765, 6504.674766261763, 6506.41442270198, 6220.129181914626, 6256.186695729526, 6263.906041409474, 6273.341299163522, 6273.96863015682, 6096.9390306096375, 6218.129461875251, 6278.0269058296035, 6444.13004244421, 6476.06097115925, 6191.690415479118, 6201.255849298113, 6206.317305096526, 6208.410201030895, 6212.782552610637, 6286.811395658137, 6297.779577714758, 6299.181106456132, 6303.558750887394, 6335.588186767845, 5788.421157884178, 5892.882142357214, 6010.939890601213, 6136.6011209271255, 6144.1398204250545, 6030.276366836008, 6096.116063170727, 6119.541034422347, 6128.080787881853, 6132.969335153296, 5968.4926781224085, 5999.52003839683, 6022.969885150546, 6035.064564992434, 6053.061775424816, 5879.059350503899, 5941.37615550361, 6069.666168360783, 6084.665343406155, 6159.476444502267, 5913.349531551612, 5919.6744179070565, 5938.554608404301, 6001.5798894077, 6025.0661147522205], "value": 5710.1128136487, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.7453520451002, 604.1843511259799, 635.501131611685, 648.1768154443854, 667.682850645943, 45056.0, 46641.30038049428, 46787.0, 50105.248421273616, 50119.24821127686, 46046.309305360446, 46189.0, 46545.53454465454, 46600.30099548509, 46653.0, 8838.381313308071, 8925.285977121846, 8978.461292322449, 8983.10168983103, 8997.370184087116, 8811.074837142103, 8832.8675069874, 8858.911410885874, 8864.423812452202, 8874.378793484459, 8866.335024873128, 8880.8667869982, 8903.287736981058, 8942.508162051085, 8961.0, 8847.33644976626, 8894.377393582452, 8894.555272236363, 8896.955515222415, 8915.821683566292, 8797.472151670856, 8831.646734130627, 8862.955685221532, 8882.822343553158, 8899.110088991114, 43028.139437211394, 43056.569434305566, 43315.35026974598, 43416.0, 43475.56524434778, 3656.3966945453967, 3794.962050379516, 3804.410316400935, 3963.207358528306, 4424.491183513905, 32249.677503225135, 32282.51576226335, 32484.83757581197, 32591.51112733311, 32610.0, 4438.267685831834, 4482.282834746457, 4509.819607215707, 4529.0, 4560.543945605446, 390526.0, 394035.0, 394701.0, 394920.0, 396325.0, 61826.0, 62022.0, 62117.378826212065, 62232.0, 62448.375516244254, 56836.0, 56878.14682779762, 56965.71517142388, 56974.0, 57264.713676432184, 17855.0, 18049.909750451425, 18180.545486362946, 18261.178246978918, 18262.90868545649, 14608.0, 14695.92652036733, 14721.779173312409, 14752.18862962526, 14788.63028424298, 16088.517344479684, 16776.916115419346, 16791.32834686599, 16866.831331686528, 16892.324307027582, 5953.464188223081, 6030.788922387783, 6123.96938015316, 6167.969160154171, 6204.875902481925, 985.6698006168014, 1036.8341065429495, 1053.4258828938248, 1079.8056349856945, 1092.5848177692426, 32341.191470213435, 32723.0, 32846.0, 32970.17574560655, 33370.8331458346, 1131.0612191880718, 1150.5225331487507, 1226.6136167107334, 1235.7899157143306, 1238.325112813519, 17103.0, 17663.470095897144, 18307.54231144232, 18978.0, 19029.333973311146, 571445.0, 574228.0, 577496.0, 578325.0, 579110.0, 62893.37106628875, 62980.685096575144, 62993.370066298754, 63028.36971630317, 63523.0, 1428.757111291083, 1458.6902486606425, 1459.649684075814, 1485.6880055188315, 1488.4939120699014, 32815.835920820246, 32949.67050329466, 33378.83310583432, 33438.83280583582, 33694.49458258177, 52852.47147528476, 53516.73241633767, 53595.19607205817, 53601.73199134135, 53759.73120134374, 491618.0, 493278.0, 494923.0, 496001.0, 497457.0, 30013.249668758457, 47968.760156198994, 48019.03961920812, 48654.75672621614, 49257.50742492673, 49131.26303105528, 49316.75341623269, 49705.50294497154, 52491.0, 52901.73549132384, 43477.56522434735, 43559.56440435682, 43635.12729745324, 45444.54555454535, 45647.08705825798, 42081.78959105185, 42934.78530622009, 43338.34992475178, 43815.78092109519, 44929.10141797081, 44865.0, 45405.31892021689, 45620.77189614163, 45862.0, 45924.770376147906, 36561.0, 38611.841644750704, 39401.802990986005, 39561.80219098886, 39704.80147599243, 29622.555661665523, 29828.0, 29892.4409919329, 29898.252543686584, 30356.0], "value": 21231.979989004565, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.9355096735491, 431.857330042057, 432.5220631202522, 436.7052239738177, 445.26975759753986, 18526.351577694782, 19143.521411964706, 20231.089600967956, 20426.69359959602, 20590.279340223096, 17731.847429917045, 18909.05454727265, 19497.41507754766, 19640.21439142436, 19677.21291148356, 5278.1291086970605, 5484.067708489546, 5518.834434966958, 5533.972330138344, 5535.861603459925, 5273.8945221095555, 5394.244805727181, 5422.701751403672, 5441.918371224435, 5448.42791506892, 5422.945770542284, 5440.755166017539, 5459.426760190182, 5461.371942226655, 5467.043267428204, 5207.973960130175, 5362.249285100089, 5416.943695979286, 5430.755615997289, 5438.782448702047, 5256.316678831766, 5268.60485463588, 5269.710165940872, 5289.0744119779265, 5301.522862942354, 15142.167180805161, 19276.518087047796, 24454.877725611437, 24681.38296542583, 24741.5051698965, 2399.3761621978238, 2410.8071354291615, 2430.9149179778624, 2454.006127518358, 2454.2882564056404, 10954.890451095467, 10983.286086404358, 11022.889771102267, 11062.05972492331, 11241.83137252942, 1997.3808119483008, 2017.8385729141633, 2052.568960518293, 2090.4982804127053, 2110.482931681732, 86532.56733716291, 86838.5658071712, 88957.55521222418, 90261.54869225678, 90894.0, 11490.88509114898, 11629.47667354971, 11633.767324653629, 11982.940085299517, 12092.214006089576, 17247.65504689899, 17448.5637859052, 17474.388396406066, 17475.21361538734, 17480.21339039746, 8988.685396011108, 8993.0, 9039.186473217442, 9231.399959002643, 9285.535723213947, 8628.568571571397, 8642.395032347675, 8702.260307873901, 8917.152870477294, 8940.642374304955, 5146.639735218499, 5166.147585648401, 5193.792248310101, 5244.895102097937, 5356.4107948125675, 2000.369883486697, 2054.2296638760463, 2060.2171174953423, 2094.204202403077, 2126.181420153252, 948.3124734567383, 957.2772556719632, 1017.976933182162, 1032.4940779018227, 1092.1754075672816, 19443.4166974991, 20068.39794806158, 20845.68731469029, 20925.686114707987, 20955.26656567013, 1033.7105610429091, 1058.1481907064733, 1073.2809017957986, 1074.7474343529263, 1095.5684257179569, 11246.718832029264, 11708.356040417859, 11723.296602203895, 11755.235909665844, 11883.821742673867, 535724.0, 544008.0, 571726.0, 586286.0, 590988.0, 91581.5420922891, 93922.0, 97714.51142744241, 100634.4968275154, 100790.0, 512.4875124875125, 538.0583978038433, 539.900118478075, 540.3326891289255, 541.8753686652013, 11512.424378781196, 11943.761124777282, 11961.64115076549, 12233.0, 12347.13570050088, 39898.999999998836, 42238.366424503045, 42263.366049508666, 43456.782716086214, 44186.0, 62756.37243627688, 63392.0, 63679.36320636734, 64143.037854431284, 64371.678141608994, 9326.300527460604, 9556.139947404488, 9621.230301575717, 9668.419894806335, 9739.659111931049, 7386.630668466448, 10554.78890422172, 11373.54505819758, 13685.45258189701, 13983.720325593227, 12014.579489718168, 12231.69420764488, 12355.135140540435, 12369.196002259825, 12697.619071427873, 11694.590689325832, 12013.099017573892, 12292.201006934522, 12300.630981070582, 12334.136610437543, 11279.0, 11308.434578271219, 12536.059795515555, 12737.55418560346, 12803.0, 9325.440473571607, 9408.623655053994, 9573.569189386633, 9619.855702164614, 9671.081247281498, 9793.902060979299, 11930.582429614922, 12254.938725306316, 12392.62822115338, 12431.214610415562], "value": 9310.758621050722, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1553.262200454784, 1557.9143147126906, 1745.458907738601, 1787.2225581871878, 1826.2238548616842, 7993.240642138988, 8220.095789463154, 8547.145285471457, 9077.364584479097, 9099.681511147111, 8130.430869839113, 8459.196376344238, 8472.830543389144, 8603.870941935877, 8630.223279904807, 2465.790407815338, 2490.402303447169, 2501.2746303571944, 2501.3496490912403, 2505.1607711416696, 2462.938426539333, 2575.163072001598, 2575.484903019394, 2577.201067669029, 2579.290695058855, 2473.51766405551, 2476.306634142434, 2496.2885577610386, 2497.1384872219146, 2529.2791554407, 2437.7805997460223, 2442.6702395176603, 2452.4849781545895, 2460.372604985726, 2465.704115506133, 2417.528581926525, 2459.8032157427365, 2474.4308808974038, 2486.532945562109, 2501.574732295496, 9063.13900179482, 9073.455592664395, 9105.590248438835, 9108.954455227682, 9125.17873391398, 5622.381538030813, 5827.912581311284, 5830.883382332372, 5836.328822185461, 5841.415858414167, 3562.8040457774814, 3580.7314451415987, 3645.908852278714, 3683.4843121962945, 3704.462852886343, 1198.233130796291, 1205.2828567002618, 1237.6225251298351, 1265.2661456355384, 1269.2765123879392, 12636.05229607783, 12655.557055503104, 12681.175723577939, 12761.744765104646, 12789.360531973363, 4797.952020479751, 5083.517065878736, 5092.694438333712, 5101.566366858859, 5196.636235463481, 10659.94670026645, 10708.357498550113, 10730.463476826128, 10738.892611073945, 10751.0, 5655.660660360391, 5669.744861481243, 5670.971645141748, 5690.118031705092, 5707.3721890592005, 4439.267520859086, 4829.323894654751, 4996.750162491933, 4999.575036121971, 5249.737513124329, 4184.4141820145205, 4240.5123410808155, 4304.375865499485, 4342.761148136883, 4349.151915376535, 1442.3365251983996, 1445.0968144909432, 1450.0719539494733, 1451.7459444597152, 1476.6677497562962, 959.4051687953513, 971.2133172130597, 978.5694294510392, 990.4997976022063, 991.2862738828032, 5913.231279933581, 5951.732172052268, 6091.208142941389, 6140.508759299245, 6199.380061993855, 505.74207154351546, 508.8244555628302, 513.6507175120954, 518.082993102207, 518.8028549151373, 4175.144095460423, 4195.853145139906, 4206.305959516645, 4226.429432026698, 4233.915321693549, 10856.945715271531, 11081.224314297922, 11150.888491115147, 11190.888091119148, 11196.216264861381, 11138.498767555317, 11216.831747523795, 11224.719382015515, 11228.887711122785, 11240.100791936626, 8129.79675508117, 8452.915470845335, 8464.280536154496, 8493.702720404755, 8665.956670216734, 6117.724702388492, 6154.9996251217635, 6280.780172693934, 6300.59046161998, 6419.325970773001, 9606.27952903549, 10526.210534210119, 10567.365958042543, 10568.154547636324, 10572.101371383518, 10028.147607453448, 10200.0, 10201.336913100922, 10254.0, 10273.434961077213, 7137.1435427749, 7615.428842836699, 7910.604469776603, 7935.920640793749, 8006.679732810622, 8803.119688031145, 8908.55457227123, 8969.14793094655, 9010.954945225232, 9021.774455638662, 7719.845603088019, 7831.70776821818, 7860.528368297921, 8016.639251233825, 8077.071136819341, 7816.804579885321, 7841.411894108079, 7848.7645370638975, 7943.682252709827, 8151.30713889326, 7141.750038748619, 7185.461090418135, 7211.350978411968, 7213.0, 7216.061911951413, 4704.435467743892, 4715.952840471551, 4794.520547945178, 4898.0, 4966.106100901728, 5007.5486928056425, 5066.113430149635, 5133.332666753298, 5171.560417364566, 5183.041137389595], "value": 4748.779110107072, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.48665921073655, 362.05503635511326, 364.42420974859715, 364.9215418684982, 365.533944221118, 5661.4338566143415, 5686.0, 5735.369109397968, 5764.769409223636, 5779.942200577993, 5521.4478552144765, 5621.578381621374, 5622.746976386063, 5635.3237611486575, 5687.6303040302355, 4388.23205938961, 4442.2004039272915, 4446.199289287827, 4447.930143918311, 4464.151811155886, 4445.51099379068, 4446.555344465543, 4447.866564003069, 4474.955250447487, 4482.551744825508, 4432.15789000089, 4442.577955094261, 4454.020115574568, 4457.175422546823, 4495.617872480843, 4404.801783919731, 4438.622717069053, 4445.955540444586, 4457.130859482386, 4473.776311184428, 3981.5222173339384, 4000.859754969849, 4004.3192657248337, 4005.1589166274825, 4007.6393124618926, 5487.64330318528, 5498.532624726903, 5506.779728810843, 5547.3343198816, 5576.442355764431, 4980.402351717781, 4992.925106123411, 5091.414487333967, 5118.513741194618, 5142.7685754140775, 5893.58744887858, 5909.261342332208, 5943.227380440559, 5954.732037058343, 5961.731722072517, 4423.0, 4453.844115455976, 4456.0, 4465.531119232466, 4476.194285028693, 5860.765569377219, 5938.7624495020145, 6057.757689692407, 6130.693465326761, 6149.477294429934, 4357.716748411343, 4373.431453910971, 4374.19077470669, 4383.780810959439, 4395.63735242076, 4420.270655341897, 4451.399061126771, 4473.6868419211, 4474.932876006863, 4476.686631935799, 4936.605071594264, 4982.153033984231, 5086.694798312039, 5096.898062038738, 5117.283580298761, 5901.734421951022, 5907.881842363128, 5909.172715819789, 5920.792772253037, 5926.496247818984, 1478.7264356094156, 1489.121418363171, 1491.261825396414, 1491.4108926973784, 1496.7006598680307, 995.3729150635054, 1034.4414016431194, 1043.5721354244874, 1052.1372474570778, 1055.4775386183887, 5617.792174682381, 5628.634138780966, 5651.2935883014625, 5691.77232910679, 5713.942860571424, 5910.0, 5959.7914073008105, 5960.403959604005, 5979.372165922602, 6037.969810150921, 5299.0, 5567.638103523258, 5574.777008919679, 5611.9593892398225, 5660.433956604306, 3121.4849549824025, 3148.3860647173583, 3186.091963790355, 3206.0061380971506, 3216.726578240829, 5837.620554663933, 6035.215421995113, 6114.0, 6289.779857704958, 6299.968500157562, 5946.554008449383, 5969.313528944227, 5991.400859914061, 6027.6684782336515, 6040.184575082396, 6112.388761123852, 6181.876362472815, 6184.855801676704, 6221.47117495018, 6238.344973777779, 5724.942750572441, 5755.7122143893475, 5783.240893419311, 5807.912881306868, 5809.62237454581, 5769.53843692512, 5771.422857714195, 5852.824415267549, 5889.293284805679, 5894.585299528168, 6095.2685677718955, 6168.691565421801, 6220.315765265907, 6224.439800417984, 6278.560500764903, 4362.825486980612, 4389.714668546534, 4390.912181756283, 4401.933970990373, 4434.778261086997, 5822.76708931655, 6075.210222671025, 6134.969325153345, 6154.692265386802, 6179.721912513858, 5965.463108320272, 5989.8203053908455, 5991.940080599138, 5996.44092535935, 6000.609960352563, 6006.939930600638, 6024.3674414187635, 6025.523746682091, 6054.152418661303, 6072.483838873745, 5643.915341269966, 5912.0, 5925.911111333419, 5972.34304226526, 5999.640021598718, 6068.177048459443, 6088.817335479943, 6106.6336019838955, 6126.693665316806, 6152.200213972155, 5594.664320140804, 5854.765809367577, 5867.5305975521005, 5910.822675319747, 5991.670458124845], "value": 4531.118863525083, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.08289141225, 704.6828926982859, 712.1596516110989, 735.2794261623612, 752.6913965274239, 14224.075435096724, 15020.624484387896, 15035.09789412636, 15064.698706025873, 15094.924525377386, 14041.719165616681, 14299.571012869605, 14366.138031718105, 14420.855791442109, 14482.203478808688, 701.5720410549561, 712.9287071292881, 807.6284908941865, 825.4180802534199, 839.6851180807182, 840.8318336332758, 846.8687353460224, 848.1391387741447, 848.749618862434, 850.2475309351238, 892.2415946445534, 894.0433735902587, 894.6153154143716, 895.6820328783285, 897.1253028297391, 886.2555453419127, 886.3972498700913, 886.5567216391804, 888.4580405952364, 889.4396530185974, 652.5530011941835, 655.5968079630993, 656.7701304543372, 657.0144782825762, 657.81252343082, 13977.23125228112, 14035.719285614332, 14081.577552673436, 14146.504872329419, 14969.700605987928, 13972.51096211638, 14552.854471455255, 14676.486322978644, 14729.558113256513, 14805.0, 12089.637310880687, 12144.757104857854, 12153.331566763825, 12209.572664956773, 12356.135070545066, 3697.759645623026, 3706.2772759311947, 3741.9251614967548, 3789.621037896216, 3790.4124860646366, 64441.67779161074, 65332.67333663349, 66630.0, 67211.0, 68699.65650171717, 10327.638532651321, 10665.253432259822, 10852.294600850919, 11089.534848982736, 11341.0, 20015.299464518674, 20159.8992005042, 20312.492187695425, 20320.69518957217, 20360.69458958117, 8002.559859207683, 8071.394645401619, 8075.273225409741, 8131.064927533291, 8368.37237207212, 4585.656075794329, 4634.791434385461, 4637.582617564435, 4704.341392205094, 4772.570468657837, 3324.7173990210617, 3430.142464383904, 3430.2453460238708, 3433.073070271013, 3821.159344944108, 722.9674664640104, 724.5580196080386, 728.457299312016, 728.5337384074197, 735.3308489274734, 695.2074634916199, 730.7442395161758, 772.4515593928262, 782.6126067596463, 815.3517953227199, 9053.864192037125, 9141.588628511732, 9142.314326425545, 9342.719718408458, 9617.615295388106, 588.3057991569989, 612.1919066831739, 659.475716805141, 684.8459096703301, 696.9686364113627, 4567.200739870509, 4774.092922344744, 4841.491643377465, 4847.75761211938, 4878.560929516289, 70998.64500677463, 75398.62300688462, 94386.0, 95948.52025739827, 96683.51658241663, 47312.526874730815, 71983.0, 72746.63626681939, 74127.62936185284, 74358.6282068597, 56925.0, 67330.32669673339, 69788.30211697919, 70226.64886675533, 71248.99999999897, 10026.947170546988, 10344.793104138025, 10384.532696028546, 10398.480075996322, 10521.631742888962, 32936.0, 33185.83407082949, 37023.62976370202, 40550.1889962205, 41987.0, 22717.659235111816, 24347.75652243455, 39904.0, 50412.747936260086, 59887.70056149692, 13207.801882971571, 13285.734285314433, 13491.595252142451, 13587.524436645066, 13612.93193534026, 13912.165270083828, 14056.508022219174, 14499.85500144985, 15104.622384440478, 15286.847131528988, 12882.0, 13138.540151094665, 13346.532871349456, 13424.93287533556, 14145.0, 13317.66705832362, 13866.930665346608, 13984.790228146383, 14108.576742697325, 14337.283135843374, 13998.300084995506, 14079.718405632035, 14111.435542578181, 14141.434342626591, 14195.722384985402, 9872.901270987199, 10581.52383142745, 11702.70743231426, 11741.412929353328, 11928.165028447926, 11315.0, 11447.51182346323, 11624.767504650028, 11720.179587429138, 11757.882421175678], "value": 7165.742392167837, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1465.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 113.0, 111.0, 111.0, 112.0, 110.0, 110.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 125.0, 123.0, 157.0, 124.0, 122.0, 124.0, 129.0, 149.0, 122.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 163.0, 162.0, 161.0, 162.0, 161.0, 163.0, 162.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 74.0, 106.0, 75.0, 76.0, 75.0, 75.0, 105.0, 74.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 107.0, 82.0, 82.0, 82.0, 100.0, 81.0, 82.0, 99.0], "value": 87.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 120.0, 117.0, 117.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 148.0, 148.0, 149.0, 149.0, 147.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 87.0, 85.0, 84.0, 84.0, 85.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 50.0, 49.0, 51.0, 50.0, 51.0, 51.0, 50.0, 50.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 58.0, 60.0, 60.0, 60.0, 59.0, 59.0, 59.0, 61.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 79.0, 82.0, 76.0, 78.0, 75.0, 76.0, 83.0, 76.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 130.0, 128.0, 127.0, 146.0, 132.0, 137.0, 172.0, 127.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 158.0, 159.0, 162.0, 153.0, 153.0, 154.0, 152.0, 153.0, 154.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 62.0, 63.0, 64.0, 63.0, 66.0, 64.0, 62.0, 62.0], "value": 63.4, "unit": "score"}]}]} 04:06:24 INFO - Return code: 0 04:06:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:06:24 ERROR - # TBPL SUCCESS # 04:06:24 INFO - Running post-action listener: _resource_record_post_action 04:06:24 INFO - [mozharness: 2016-12-01 12:06:24.394237Z] Finished run-tests step (success) 04:06:24 INFO - Running post-run listener: _resource_record_post_run 04:06:24 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 356581376; Read time: 20; Write time: 270464 04:06:24 INFO - TinderboxPrint: CPU usage
13.3% 04:06:24 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 20 04:06:24 INFO - TinderboxPrint: I/O write bytes / time
356,581,376 / 270,464 04:06:24 INFO - TinderboxPrint: CPU idle
8,221.0 (86.7%) 04:06:24 INFO - TinderboxPrint: CPU user
1,208.4 (12.7%) 04:06:24 INFO - TinderboxPrint: Swap in / out
0 / 0 04:06:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108097536; Read time: 0; Write time: 108228 04:06:24 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248483840; Read time: 12; Write time: 162236 04:06:25 INFO - Running post-run listener: _upload_blobber_files 04:06:25 INFO - Blob upload gear active. 04:06:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:06:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:06:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:06:25 INFO - (blobuploader) - INFO - Open directory for files ... 04:06:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:06:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:06:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:06:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:06:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:06:26 INFO - (blobuploader) - INFO - Done attempting. 04:06:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:06:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:06:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:06:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:06:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:06:27 INFO - (blobuploader) - INFO - Done attempting. 04:06:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:06:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:06:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:06:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:06:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:06:31 INFO - (blobuploader) - INFO - Done attempting. 04:06:31 INFO - (blobuploader) - INFO - Iteration through files over. 04:06:31 INFO - Return code: 0 04:06:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:06:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:06:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d7f5617bf19dfa58ae7d17f38ebac870768a26997d1469fdd8f37339926613e58c682f5b25dfd8e04360f08c1429a29bcaeb1ffa3e28bcae34752f5d4bbdf36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bbc5fd7555866344bb2cd57d66648ed8e05bd4c75206e0b0b788b29c554043776b770e1c2953745616073b0eba74b4339ab4d2d31b4c15f4ba1b27f69e03f7d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c314f76ad475aa27919bfaa2fdcebfb78253c652cbcf73b82b931aa55c28c3abd0ee9c80cb63d7ef657720990605bad44ea39d47a5b7603f517229a158490c3"} 04:06:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:06:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:06:31 INFO - Contents: 04:06:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d7f5617bf19dfa58ae7d17f38ebac870768a26997d1469fdd8f37339926613e58c682f5b25dfd8e04360f08c1429a29bcaeb1ffa3e28bcae34752f5d4bbdf36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bbc5fd7555866344bb2cd57d66648ed8e05bd4c75206e0b0b788b29c554043776b770e1c2953745616073b0eba74b4339ab4d2d31b4c15f4ba1b27f69e03f7d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c314f76ad475aa27919bfaa2fdcebfb78253c652cbcf73b82b931aa55c28c3abd0ee9c80cb63d7ef657720990605bad44ea39d47a5b7603f517229a158490c3"} 04:06:31 INFO - Running post-run listener: copy_logs_to_upload_dir 04:06:31 INFO - Copying logs to upload dir... 04:06:31 INFO - mkdir: /builds/slave/test/build/upload/logs 04:06:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.841638 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-01 04:06:31.196925) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 04:06:31.202341) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d7f5617bf19dfa58ae7d17f38ebac870768a26997d1469fdd8f37339926613e58c682f5b25dfd8e04360f08c1429a29bcaeb1ffa3e28bcae34752f5d4bbdf36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bbc5fd7555866344bb2cd57d66648ed8e05bd4c75206e0b0b788b29c554043776b770e1c2953745616073b0eba74b4339ab4d2d31b4c15f4ba1b27f69e03f7d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c314f76ad475aa27919bfaa2fdcebfb78253c652cbcf73b82b931aa55c28c3abd0ee9c80cb63d7ef657720990605bad44ea39d47a5b7603f517229a158490c3"} build_url:https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011155 build_url: 'https://queue.taskcluster.net/v1/task/VhAvuFpCSRGFRQEJahQnNw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d7f5617bf19dfa58ae7d17f38ebac870768a26997d1469fdd8f37339926613e58c682f5b25dfd8e04360f08c1429a29bcaeb1ffa3e28bcae34752f5d4bbdf36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bbc5fd7555866344bb2cd57d66648ed8e05bd4c75206e0b0b788b29c554043776b770e1c2953745616073b0eba74b4339ab4d2d31b4c15f4ba1b27f69e03f7d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c314f76ad475aa27919bfaa2fdcebfb78253c652cbcf73b82b931aa55c28c3abd0ee9c80cb63d7ef657720990605bad44ea39d47a5b7603f517229a158490c3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 04:06:31.227946) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 04:06:31.228280) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1480592701.977269-203381753 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 04:06:31.311119) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 04:06:31.311450) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 04:06:31.311759) ========= ========= Total master_lag: 0.18 =========