builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1475770677.22 results: success (0) buildid: 20161006063000 builduid: 933cde5b59e349158ee6762268a2ec14 revision: 993bd0c52f8addd18cdf4163acd645e51090c679 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 09:17:57.223396) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 09:17:57.223849) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 09:17:57.224162) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 09:17:57.239112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 09:17:57.239438) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 09:17:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.7M=0s 2016-10-06 09:17:57 (66.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126379 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 09:17:57.379572) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 09:17:57.379910) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014553 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 09:17:57.429643) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 09:17:57.430007) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 993bd0c52f8addd18cdf4163acd645e51090c679 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 993bd0c52f8addd18cdf4163acd645e51090c679 --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=a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 09:17:57,749 truncating revision to first 12 chars 2016-10-06 09:17:57,749 Setting DEBUG logging. 2016-10-06 09:17:57,749 attempt 1/10 2016-10-06 09:17:57,750 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/993bd0c52f8a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 09:17:58,041 unpacking tar archive at: fx-team-993bd0c52f8a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625187 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 09:17:58.068729) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 09:17:58.069078) ========= script_repo_revision: 993bd0c52f8addd18cdf4163acd645e51090c679 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 09:17:58.069473) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 09:17:58.069760) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 09:17:58.079309) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-06 09:17:58.079602) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:17:58 INFO - MultiFileLogger online at 20161006 09:17:58 in /builds/slave/test 09:17:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:17:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:17:58 INFO - {'append_to_log': False, 09:17:58 INFO - 'base_work_dir': '/builds/slave/test', 09:17:58 INFO - 'blob_upload_branch': 'Fx-Team', 09:17:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:17:58 INFO - 'branch': 'Fx-Team', 09:17:58 INFO - 'buildbot_json_path': 'buildprops.json', 09:17:58 INFO - 'config_files': ('talos/linux_config.py',), 09:17:58 INFO - 'default_actions': ('clobber', 09:17:58 INFO - 'read-buildbot-config', 09:17:58 INFO - 'download-and-extract', 09:17:58 INFO - 'populate-webroot', 09:17:58 INFO - 'create-virtualenv', 09:17:58 INFO - 'install', 09:17:58 INFO - 'run-tests'), 09:17:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:17:58 INFO - 'download_minidump_stackwalk': True, 09:17:58 INFO - 'download_symbols': 'ondemand', 09:17:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:17:58 INFO - 'tooltool.py': '/tools/tooltool.py', 09:17:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:17:58 INFO - '/tools/misc-python/virtualenv.py')}, 09:17:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:17:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:17:58 INFO - 'installer_path': 'installer.exe', 09:17:58 INFO - 'log_level': 'info', 09:17:58 INFO - 'log_name': 'talos', 09:17:58 INFO - 'log_to_console': True, 09:17:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:17:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:17:58 INFO - 'opt_config_files': (), 09:17:58 INFO - 'pip_index': False, 09:17:58 INFO - 'sps_profile': False, 09:17:58 INFO - 'sps_profile_interval': 0, 09:17:58 INFO - 'suite': 'dromaeojs', 09:17:58 INFO - 'system_bits': '32', 09:17:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:17:58 INFO - 'title': 'talos-linux64-ix-062', 09:17:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:17:58 INFO - 'use_talos_json': True, 09:17:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:17:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:17:58 INFO - 'work_dir': 'build'} 09:17:58 INFO - [mozharness: 2016-10-06 16:17:58.498583Z] Running clobber step. 09:17:58 INFO - Running pre-action listener: _resource_record_pre_action 09:17:58 INFO - Running main action method: clobber 09:17:58 INFO - rmtree: /builds/slave/test/build 09:17:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:17:59 INFO - Running post-action listener: _resource_record_post_action 09:17:59 INFO - [mozharness: 2016-10-06 16:17:59.003765Z] Finished clobber step (success) 09:17:59 INFO - [mozharness: 2016-10-06 16:17:59.003864Z] Running read-buildbot-config step. 09:17:59 INFO - Running pre-action listener: _resource_record_pre_action 09:17:59 INFO - Running main action method: read_buildbot_config 09:17:59 INFO - Using buildbot properties: 09:17:59 INFO - { 09:17:59 INFO - "project": "", 09:17:59 INFO - "product": "firefox", 09:17:59 INFO - "script_repo_revision": "production", 09:17:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:17:59 INFO - "repository": "", 09:17:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 09:17:59 INFO - "buildid": "20161006063000", 09:17:59 INFO - "pgo_build": "True", 09:17:59 INFO - "basedir": "/builds/slave/test", 09:17:59 INFO - "buildnumber": 1111, 09:17:59 INFO - "slavename": "talos-linux64-ix-062", 09:17:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:17:59 INFO - "platform": "ubuntu64_hw", 09:17:59 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:17:59 INFO - "branch": "fx-team", 09:17:59 INFO - "repo_path": "integration/fx-team", 09:17:59 INFO - "revision": "993bd0c52f8addd18cdf4163acd645e51090c679", 09:17:59 INFO - "stage_platform": "linux64-pgo", 09:17:59 INFO - "builduid": "933cde5b59e349158ee6762268a2ec14", 09:17:59 INFO - "slavebuilddir": "test" 09:17:59 INFO - } 09:17:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:17:59 INFO - Running post-action listener: _resource_record_post_action 09:17:59 INFO - [mozharness: 2016-10-06 16:17:59.006289Z] Finished read-buildbot-config step (success) 09:17:59 INFO - [mozharness: 2016-10-06 16:17:59.006378Z] Running download-and-extract step. 09:17:59 INFO - Running pre-action listener: _resource_record_pre_action 09:17:59 INFO - Running main action method: download_and_extract 09:17:59 INFO - mkdir: /builds/slave/test/build/tests 09:17:59 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')]} 09:17:59 INFO - trying https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:17:59 INFO - Downloading https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:17:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:17:59 INFO - Downloaded 1361 bytes. 09:17:59 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:17:59 INFO - Using the following test package requirements: 09:17:59 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:17:59 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:17:59 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:17:59 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:59 INFO - u'jsshell-linux-x86_64.zip'], 09:17:59 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:17:59 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:17:59 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:17:59 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:17:59 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:17:59 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:59 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:17:59 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:17:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:17:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:17:59 INFO - Fetch https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:18:00 INFO - Http code: 200 09:18:00 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 09:18:00 INFO - x-amz-cf-id: fcLwDKFk6tu89mbJX8ZDvUkmpiBedFy0eUrSblz9tkP1do8Oj7pJIw== 09:18:00 INFO - x-amz-version-id: cblxSugic6i82asih5XyDOobmrPqeBne 09:18:00 INFO - Expected file size: 22018116 09:18:00 INFO - Obtained file size: 22018116 09:18:04 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:18:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:18:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:18:04 INFO - Fetch https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:18:05 INFO - Http code: 200 09:18:05 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 09:18:05 INFO - x-amz-cf-id: MaJVgceBYhACVLadM7YTLuNcHpSrrxxo52DL3fN92yqy1f17FyZ-HQ== 09:18:05 INFO - x-amz-version-id: cblxSugic6i82asih5XyDOobmrPqeBne 09:18:05 INFO - Expected file size: 22018116 09:18:05 INFO - Obtained file size: 22018116 09:18:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:18:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:18:09 INFO - Fetch https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:18:10 INFO - Http code: 200 09:18:10 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 09:18:10 INFO - x-amz-cf-id: qf8rVwJq6Dlx777Ij5I7EnLga3Ob9uspxqSw_XLYdRrjt99qOwaecg== 09:18:10 INFO - x-amz-version-id: Ie9Wqx1KlS.xRHHUWSlBiO6G.5cNGzfa 09:18:10 INFO - Expected file size: 14409006 09:18:10 INFO - Obtained file size: 14409006 09:18: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')]} 09:18:10 INFO - trying https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:18:10 INFO - Downloading https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:18:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:18:11 INFO - Downloaded 59708009 bytes. 09:18:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:18:11 INFO - mkdir: /builds/slave/test/properties 09:18:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:18:11 INFO - Writing to file /builds/slave/test/properties/build_url 09:18:11 INFO - Contents: 09:18:11 INFO - build_url:https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:18:12 INFO - Running post-action listener: _resource_record_post_action 09:18:12 INFO - Running post-action listener: set_extra_try_arguments 09:18:12 INFO - [mozharness: 2016-10-06 16:18:12.516449Z] Finished download-and-extract step (success) 09:18:12 INFO - [mozharness: 2016-10-06 16:18:12.516675Z] Running populate-webroot step. 09:18:12 INFO - Running pre-action listener: _resource_record_pre_action 09:18:12 INFO - Running main action method: populate_webroot 09:18:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:18:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:18:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:18:12 INFO - '--tppagecycles', 09:18:12 INFO - '7'], 09:18:12 INFO - 'tests': ['tsvgm']}}, 09:18:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:18:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:18:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:18:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:18:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:18:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:18:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:12 INFO - 'talos_options': ['--disable-e10s'], 09:18:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:12 INFO - 'talos_options': ['--disable-e10s'], 09:18:12 INFO - 'tests': ['damp', 'tps']}, 09:18:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:12 INFO - 'tests': ['damp', 'tps']}, 09:18:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:18:12 INFO - 'tests': ['dromaeo_dom']}, 09:18:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:18:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:18:12 INFO - 'tests': ['basic_compositor_video']}, 09:18:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:18:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:18:12 INFO - 'tests': ['a11yr', 09:18:12 INFO - 'ts_paint', 09:18:12 INFO - 'tpaint', 09:18:12 INFO - 'sessionrestore', 09:18:12 INFO - 'sessionrestore_no_auto_restore', 09:18:12 INFO - 'tabpaint']}, 09:18:12 INFO - 'other-e10s': {'tests': ['a11yr', 09:18:12 INFO - 'ts_paint', 09:18:12 INFO - 'tpaint', 09:18:12 INFO - 'sessionrestore', 09:18:12 INFO - 'sessionrestore_no_auto_restore', 09:18:12 INFO - 'tabpaint']}, 09:18:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:18:12 INFO - 'ts_paint', 09:18:12 INFO - 'tpaint', 09:18:12 INFO - 'sessionrestore', 09:18:12 INFO - 'sessionrestore_no_auto_restore', 09:18:12 INFO - 'tabpaint']}, 09:18:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:18:12 INFO - 'ts_paint', 09:18:12 INFO - 'tpaint', 09:18:12 INFO - 'sessionrestore', 09:18:12 INFO - 'sessionrestore_no_auto_restore', 09:18:12 INFO - 'tabpaint']}, 09:18:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:18:12 INFO - 'tests': ['a11yr', 09:18:12 INFO - 'ts_paint', 09:18:12 INFO - 'tpaint', 09:18:12 INFO - 'sessionrestore', 09:18:12 INFO - 'sessionrestore_no_auto_restore', 09:18:12 INFO - 'tabpaint']}, 09:18:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:18:12 INFO - 'tests': ['a11yr', 09:18:12 INFO - 'ts_paint', 09:18:12 INFO - 'tpaint', 09:18:12 INFO - 'sessionrestore', 09:18:12 INFO - 'sessionrestore_no_auto_restore', 09:18:12 INFO - 'tabpaint']}, 09:18:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:18:12 INFO - 'tests': ['tsvgx', 09:18:12 INFO - 'tsvgr_opacity', 09:18:12 INFO - 'tart', 09:18:12 INFO - 'tscrollx', 09:18:12 INFO - 'cart']}, 09:18:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:18:12 INFO - 'tsvgr_opacity', 09:18:12 INFO - 'tart', 09:18:12 INFO - 'tscrollx', 09:18:12 INFO - 'cart']}, 09:18:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:12 INFO - 'talos_options': ['--disable-e10s'], 09:18:12 INFO - 'tests': ['tp5o']}, 09:18:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:12 INFO - 'tests': ['tp5o']}, 09:18:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:12 INFO - 'talos_options': ['--disable-e10s', 09:18:12 INFO - '--xperf_path', 09:18:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:12 INFO - 'tests': ['tp5n']}, 09:18:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:12 INFO - 'talos_options': ['--xperf_path', 09:18:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:12 INFO - 'tests': ['tp5n']}}, 09:18:12 INFO - 'talos.zip': {'path': '', 09:18:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:18:12 INFO - Running post-action listener: _resource_record_post_action 09:18:12 INFO - [mozharness: 2016-10-06 16:18:12.533916Z] Finished populate-webroot step (success) 09:18:12 INFO - [mozharness: 2016-10-06 16:18:12.534004Z] Running create-virtualenv step. 09:18:12 INFO - Running pre-action listener: _resource_record_pre_action 09:18:12 INFO - Running main action method: create_virtualenv 09:18:12 INFO - Creating virtualenv /builds/slave/test/build/venv 09:18: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 09:18:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:18:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:18:12 INFO - Using real prefix '/usr' 09:18:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:18:13 INFO - Installing distribute.............................................................................................................................................................................................done. 09:18:15 INFO - Installing pip.................done. 09:18:15 INFO - Return code: 0 09:18:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:18:15 INFO - Reading from file tmpfile_stdout 09:18:15 INFO - Output received: 09:18:15 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) 09:18:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:18: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')]} 09:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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')]} 09:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3a8748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d9790>, '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 0x18da690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dab20>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', '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 09:18: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', 'pip>=1.5'] in /builds/slave/test/build 09:18: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 pip>=1.5 09:18:15 INFO - Using env: {'DISPLAY': ':0', 09:18:15 INFO - 'HOME': '/home/cltbld', 09:18:15 INFO - 'LANG': 'en_US.UTF-8', 09:18:15 INFO - 'LANGUAGE': 'en_US:en', 09:18:15 INFO - 'LOGNAME': 'cltbld', 09:18:15 INFO - 'MAIL': '/var/mail/cltbld', 09:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:15 INFO - 'MOZ_NO_REMOTE': '1', 09:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:15 INFO - 'NO_EM_RESTART': '1', 09:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:15 INFO - 'PWD': '/builds/slave/test', 09:18:15 INFO - 'SHELL': '/bin/bash', 09:18:15 INFO - 'SHLVL': '1', 09:18:15 INFO - 'TERM': 'linux', 09:18:15 INFO - 'TMOUT': '86400', 09:18:15 INFO - 'USER': 'cltbld', 09:18:15 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', 09:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:15 INFO - '_': '/tools/buildbot/bin/python'} 09:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18: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 09:18:15 INFO - Cleaning up... 09:18:15 INFO - Return code: 0 09:18:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:18: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')]} 09:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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')]} 09:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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 0x7fc3a8748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d9790>, '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 0x18da690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dab20>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', '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 09:18: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 09:18: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 09:18:15 INFO - Using env: {'DISPLAY': ':0', 09:18:15 INFO - 'HOME': '/home/cltbld', 09:18:15 INFO - 'LANG': 'en_US.UTF-8', 09:18:15 INFO - 'LANGUAGE': 'en_US:en', 09:18:15 INFO - 'LOGNAME': 'cltbld', 09:18:15 INFO - 'MAIL': '/var/mail/cltbld', 09:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:15 INFO - 'MOZ_NO_REMOTE': '1', 09:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:15 INFO - 'NO_EM_RESTART': '1', 09:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:15 INFO - 'PWD': '/builds/slave/test', 09:18:15 INFO - 'SHELL': '/bin/bash', 09:18:15 INFO - 'SHLVL': '1', 09:18:15 INFO - 'TERM': 'linux', 09:18:15 INFO - 'TMOUT': '86400', 09:18:15 INFO - 'USER': 'cltbld', 09:18:15 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', 09:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:15 INFO - '_': '/tools/buildbot/bin/python'} 09:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:15 INFO - Downloading/unpacking psutil>=3.1.1 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:18:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:17 INFO - Installing collected packages: psutil 09:18:17 INFO - Running setup.py install for psutil 09:18:17 INFO - building 'psutil._psutil_linux' extension 09:18: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 09:18:18 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 09:18:18 INFO - building 'psutil._psutil_posix' extension 09:18:18 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 09:18:18 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 09:18:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:18 INFO - Successfully installed psutil 09:18:18 INFO - Cleaning up... 09:18:18 INFO - Return code: 0 09:18:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:18: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')]} 09:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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')]} 09:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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 0x7fc3a8748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d9790>, '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 0x18da690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dab20>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', '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 09:18: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 09:18: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 09:18:18 INFO - Using env: {'DISPLAY': ':0', 09:18:18 INFO - 'HOME': '/home/cltbld', 09:18:18 INFO - 'LANG': 'en_US.UTF-8', 09:18:18 INFO - 'LANGUAGE': 'en_US:en', 09:18:18 INFO - 'LOGNAME': 'cltbld', 09:18:18 INFO - 'MAIL': '/var/mail/cltbld', 09:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:18 INFO - 'MOZ_NO_REMOTE': '1', 09:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:18 INFO - 'NO_EM_RESTART': '1', 09:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:18 INFO - 'PWD': '/builds/slave/test', 09:18:18 INFO - 'SHELL': '/bin/bash', 09:18:18 INFO - 'SHLVL': '1', 09:18:18 INFO - 'TERM': 'linux', 09:18:18 INFO - 'TMOUT': '86400', 09:18:18 INFO - 'USER': 'cltbld', 09:18:18 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', 09:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:18 INFO - '_': '/tools/buildbot/bin/python'} 09:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:18:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:18:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:18:20 INFO - Installing collected packages: mozsystemmonitor 09:18:20 INFO - Running setup.py install for mozsystemmonitor 09:18:20 INFO - Successfully installed mozsystemmonitor 09:18:20 INFO - Cleaning up... 09:18:20 INFO - Return code: 0 09:18:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:18: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')]} 09:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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')]} 09:18:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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 0x7fc3a8748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d9790>, '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 0x18da690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dab20>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', '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 09:18: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 09:18: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 09:18:20 INFO - Using env: {'DISPLAY': ':0', 09:18:20 INFO - 'HOME': '/home/cltbld', 09:18:20 INFO - 'LANG': 'en_US.UTF-8', 09:18:20 INFO - 'LANGUAGE': 'en_US:en', 09:18:20 INFO - 'LOGNAME': 'cltbld', 09:18:20 INFO - 'MAIL': '/var/mail/cltbld', 09:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:20 INFO - 'MOZ_NO_REMOTE': '1', 09:18:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:20 INFO - 'NO_EM_RESTART': '1', 09:18:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:20 INFO - 'PWD': '/builds/slave/test', 09:18:20 INFO - 'SHELL': '/bin/bash', 09:18:20 INFO - 'SHLVL': '1', 09:18:20 INFO - 'TERM': 'linux', 09:18:20 INFO - 'TMOUT': '86400', 09:18:20 INFO - 'USER': 'cltbld', 09:18:20 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', 09:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:20 INFO - '_': '/tools/buildbot/bin/python'} 09:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:20 INFO - Downloading/unpacking jsonschema==2.5.1 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:18:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18:22 INFO - Downloading functools32-3.2.3-2.tar.gz 09:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:18:23 INFO - warning: no files found matching '*.txt' 09:18:23 INFO - no previously-included directories found matching 'build' 09:18:23 INFO - no previously-included directories found matching 'dist' 09:18:23 INFO - no previously-included directories found matching '.git*' 09:18:23 INFO - Installing collected packages: jsonschema, functools32 09:18:23 INFO - Running setup.py install for functools32 09:18:23 INFO - warning: no files found matching '*.txt' 09:18:23 INFO - no previously-included directories found matching 'build' 09:18:23 INFO - no previously-included directories found matching 'dist' 09:18:23 INFO - no previously-included directories found matching '.git*' 09:18:23 INFO - Successfully installed jsonschema functools32 09:18:23 INFO - Cleaning up... 09:18:23 INFO - Return code: 0 09:18:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:18: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')]} 09:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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')]} 09:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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 0x7fc3a8748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d9790>, '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 0x18da690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dab20>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', '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 09:18: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 09:18: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 09:18:23 INFO - Using env: {'DISPLAY': ':0', 09:18:23 INFO - 'HOME': '/home/cltbld', 09:18:23 INFO - 'LANG': 'en_US.UTF-8', 09:18:23 INFO - 'LANGUAGE': 'en_US:en', 09:18:23 INFO - 'LOGNAME': 'cltbld', 09:18:23 INFO - 'MAIL': '/var/mail/cltbld', 09:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:23 INFO - 'MOZ_NO_REMOTE': '1', 09:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:23 INFO - 'NO_EM_RESTART': '1', 09:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:23 INFO - 'PWD': '/builds/slave/test', 09:18:23 INFO - 'SHELL': '/bin/bash', 09:18:23 INFO - 'SHLVL': '1', 09:18:23 INFO - 'TERM': 'linux', 09:18:23 INFO - 'TMOUT': '86400', 09:18:23 INFO - 'USER': 'cltbld', 09:18:23 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', 09:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:23 INFO - '_': '/tools/buildbot/bin/python'} 09:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:18:23 INFO - Cleaning up... 09:18:23 INFO - Return code: 0 09:18:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:18: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')]} 09:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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')]} 09:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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 0x7fc3a8748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d9790>, '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 0x18da690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dab20>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', '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 09:18: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 09:18: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 09:18:23 INFO - Using env: {'DISPLAY': ':0', 09:18:23 INFO - 'HOME': '/home/cltbld', 09:18:23 INFO - 'LANG': 'en_US.UTF-8', 09:18:23 INFO - 'LANGUAGE': 'en_US:en', 09:18:23 INFO - 'LOGNAME': 'cltbld', 09:18:23 INFO - 'MAIL': '/var/mail/cltbld', 09:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:23 INFO - 'MOZ_NO_REMOTE': '1', 09:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:23 INFO - 'NO_EM_RESTART': '1', 09:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:23 INFO - 'PWD': '/builds/slave/test', 09:18:23 INFO - 'SHELL': '/bin/bash', 09:18:23 INFO - 'SHLVL': '1', 09:18:23 INFO - 'TERM': 'linux', 09:18:23 INFO - 'TMOUT': '86400', 09:18:23 INFO - 'USER': 'cltbld', 09:18:23 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', 09:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:23 INFO - '_': '/tools/buildbot/bin/python'} 09:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:23 INFO - Downloading/unpacking blobuploader==1.2.4 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18:25 INFO - Downloading blobuploader-1.2.4.tar.gz 09:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:18:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:18:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:18:26 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 09:18:26 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 09:18:26 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 09:18:26 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 09:18:26 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 09:18:26 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 09:18:26 INFO - Downloading docopt-0.6.1.tar.gz 09:18:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:18:26 INFO - Installing collected packages: blobuploader, requests, docopt 09:18:26 INFO - Running setup.py install for blobuploader 09:18:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:18:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:18:26 INFO - Running setup.py install for requests 09:18:26 INFO - Running setup.py install for docopt 09:18:26 INFO - Successfully installed blobuploader requests docopt 09:18:26 INFO - Cleaning up... 09:18:27 INFO - Return code: 0 09:18:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:27 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')]} 09:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:27 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')]} 09:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:27 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 0x7fc3a8748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d9790>, '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 0x18da690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dab20>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', '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 09:18:27 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 09:18:27 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 09:18:27 INFO - Using env: {'DISPLAY': ':0', 09:18:27 INFO - 'HOME': '/home/cltbld', 09:18:27 INFO - 'LANG': 'en_US.UTF-8', 09:18:27 INFO - 'LANGUAGE': 'en_US:en', 09:18:27 INFO - 'LOGNAME': 'cltbld', 09:18:27 INFO - 'MAIL': '/var/mail/cltbld', 09:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:27 INFO - 'MOZ_NO_REMOTE': '1', 09:18:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:27 INFO - 'NO_EM_RESTART': '1', 09:18:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:27 INFO - 'PWD': '/builds/slave/test', 09:18:27 INFO - 'SHELL': '/bin/bash', 09:18:27 INFO - 'SHLVL': '1', 09:18:27 INFO - 'TERM': 'linux', 09:18:27 INFO - 'TMOUT': '86400', 09:18:27 INFO - 'USER': 'cltbld', 09:18:27 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', 09:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:27 INFO - '_': '/tools/buildbot/bin/python'} 09:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:27 INFO - Running setup.py (path:/tmp/pip-vYT05u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:27 INFO - Running setup.py (path:/tmp/pip-LNatbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:27 INFO - Running setup.py (path:/tmp/pip-Bg3I71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:27 INFO - Running setup.py (path:/tmp/pip-iSVlc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:27 INFO - Running setup.py (path:/tmp/pip-AFdeh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:27 INFO - Running setup.py (path:/tmp/pip-WZ6JqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:27 INFO - Running setup.py (path:/tmp/pip-yankZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:27 INFO - Running setup.py (path:/tmp/pip-AJLpta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:27 INFO - Running setup.py (path:/tmp/pip-keW7Gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:27 INFO - Running setup.py (path:/tmp/pip-gULdi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:27 INFO - Running setup.py (path:/tmp/pip-HH2PSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:28 INFO - Running setup.py (path:/tmp/pip-unEZTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:28 INFO - Running setup.py (path:/tmp/pip-B_L0ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:28 INFO - Running setup.py (path:/tmp/pip-d8VLI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:28 INFO - Running setup.py (path:/tmp/pip-99hjS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:28 INFO - Running setup.py (path:/tmp/pip-6XxH57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:28 INFO - Running setup.py (path:/tmp/pip-TqVqTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:18:28 INFO - Running setup.py install for manifestparser 09:18:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:18:28 INFO - Running setup.py install for mozcrash 09:18:28 INFO - Running setup.py install for mozdebug 09:18:28 INFO - Running setup.py install for mozdevice 09:18:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:18:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:18:28 INFO - Running setup.py install for mozfile 09:18:29 INFO - Running setup.py install for mozhttpd 09:18:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:18:29 INFO - Running setup.py install for mozinfo 09:18:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:18:29 INFO - Running setup.py install for mozInstall 09:18:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:18:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:18:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:18:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:18:29 INFO - Running setup.py install for mozleak 09:18:29 INFO - Running setup.py install for mozlog 09:18:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:18:29 INFO - Running setup.py install for moznetwork 09:18:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:18:29 INFO - Running setup.py install for mozprocess 09:18:29 INFO - Running setup.py install for mozprofile 09:18:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:18:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:18:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:18:29 INFO - Running setup.py install for mozrunner 09:18:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:18:29 INFO - Running setup.py install for mozscreenshot 09:18:30 INFO - Running setup.py install for moztest 09:18:30 INFO - Running setup.py install for mozversion 09:18:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:18:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:18:30 INFO - Cleaning up... 09:18:30 INFO - Return code: 0 09:18:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18: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')]} 09:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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')]} 09:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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 0x7fc3a8748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d9790>, '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 0x18da690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dab20>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', '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 09:18: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 09:18: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 09:18:30 INFO - Using env: {'DISPLAY': ':0', 09:18:30 INFO - 'HOME': '/home/cltbld', 09:18:30 INFO - 'LANG': 'en_US.UTF-8', 09:18:30 INFO - 'LANGUAGE': 'en_US:en', 09:18:30 INFO - 'LOGNAME': 'cltbld', 09:18:30 INFO - 'MAIL': '/var/mail/cltbld', 09:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:30 INFO - 'MOZ_NO_REMOTE': '1', 09:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:30 INFO - 'NO_EM_RESTART': '1', 09:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:30 INFO - 'PWD': '/builds/slave/test', 09:18:30 INFO - 'SHELL': '/bin/bash', 09:18:30 INFO - 'SHLVL': '1', 09:18:30 INFO - 'TERM': 'linux', 09:18:30 INFO - 'TMOUT': '86400', 09:18:30 INFO - 'USER': 'cltbld', 09:18:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', 09:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:30 INFO - '_': '/tools/buildbot/bin/python'} 09:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:30 INFO - Running setup.py (path:/tmp/pip-0S9yxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18: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)) 09:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:30 INFO - Running setup.py (path:/tmp/pip-PPhr3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 09:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:30 INFO - Running setup.py (path:/tmp/pip-6X2MLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18: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)) 09:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:30 INFO - Running setup.py (path:/tmp/pip-_Ww7lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18: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)) 09:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:30 INFO - Running setup.py (path:/tmp/pip-lrfLj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18: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)) 09:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:30 INFO - Running setup.py (path:/tmp/pip-YttkyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18: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)) 09:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:30 INFO - Running setup.py (path:/tmp/pip-u7OPKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:31 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)) 09:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:31 INFO - Running setup.py (path:/tmp/pip-iWaQTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:31 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)) 09:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:31 INFO - Running setup.py (path:/tmp/pip-3J631v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:31 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)) 09:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:31 INFO - Running setup.py (path:/tmp/pip-sLYvCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18: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)) 09:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:31 INFO - Running setup.py (path:/tmp/pip-f6zbma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18: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)) 09:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:31 INFO - Running setup.py (path:/tmp/pip-fTyO48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18: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)) 09:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:31 INFO - Running setup.py (path:/tmp/pip-E9yvjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18: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)) 09:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:31 INFO - Running setup.py (path:/tmp/pip-epYKM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 09:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:31 INFO - Running setup.py (path:/tmp/pip-VDGjir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18: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)) 09:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:31 INFO - Running setup.py (path:/tmp/pip-Yi0N4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18: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)) 09:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:31 INFO - Running setup.py (path:/tmp/pip-6GItb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18: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)) 09:18: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==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:18: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==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:18: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)) 09:18: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)) 09:18: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)) 09:18:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18: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 09:18:33 INFO - Downloading blessings-1.6.tar.gz 09:18:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:18:33 INFO - Installing collected packages: blessings 09:18:33 INFO - Running setup.py install for blessings 09:18:33 INFO - Successfully installed blessings 09:18:33 INFO - Cleaning up... 09:18:33 INFO - Return code: 0 09:18:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:18:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:34 INFO - Reading from file tmpfile_stdout 09:18:34 INFO - Current package versions: 09:18:34 INFO - argparse == 1.2.1 09:18:34 INFO - blessings == 1.6 09:18:34 INFO - blobuploader == 1.2.4 09:18:34 INFO - docopt == 0.6.1 09:18:34 INFO - functools32 == 3.2.3-2 09:18:34 INFO - jsonschema == 2.5.1 09:18:34 INFO - manifestparser == 1.1 09:18:34 INFO - mozInstall == 1.12 09:18:34 INFO - mozcrash == 0.17 09:18:34 INFO - mozdebug == 0.1 09:18:34 INFO - mozdevice == 0.48 09:18:34 INFO - mozfile == 1.2 09:18:34 INFO - mozhttpd == 0.7 09:18:34 INFO - mozinfo == 0.9 09:18:34 INFO - mozleak == 0.1 09:18:34 INFO - mozlog == 3.4 09:18:34 INFO - moznetwork == 0.27 09:18:34 INFO - mozprocess == 0.23 09:18:34 INFO - mozprofile == 0.28 09:18:34 INFO - mozrunner == 6.12 09:18:34 INFO - mozscreenshot == 0.1 09:18:34 INFO - mozsystemmonitor == 0.3 09:18:34 INFO - moztest == 0.7 09:18:34 INFO - mozversion == 1.4 09:18:34 INFO - psutil == 3.1.1 09:18:34 INFO - requests == 1.2.3 09:18:34 INFO - wsgiref == 0.1.2 09:18:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18: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')]} 09:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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')]} 09:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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 0x7fc3a8748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d9790>, '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 0x18da690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dab20>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', '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 09:18: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 09:18: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 09:18:34 INFO - Using env: {'DISPLAY': ':0', 09:18:34 INFO - 'HOME': '/home/cltbld', 09:18:34 INFO - 'LANG': 'en_US.UTF-8', 09:18:34 INFO - 'LANGUAGE': 'en_US:en', 09:18:34 INFO - 'LOGNAME': 'cltbld', 09:18:34 INFO - 'MAIL': '/var/mail/cltbld', 09:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:34 INFO - 'MOZ_NO_REMOTE': '1', 09:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:34 INFO - 'NO_EM_RESTART': '1', 09:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:34 INFO - 'PWD': '/builds/slave/test', 09:18:34 INFO - 'SHELL': '/bin/bash', 09:18:34 INFO - 'SHLVL': '1', 09:18:34 INFO - 'TERM': 'linux', 09:18:34 INFO - 'TMOUT': '86400', 09:18:34 INFO - 'USER': 'cltbld', 09:18:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', 09:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:34 INFO - '_': '/tools/buildbot/bin/python'} 09:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18: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)) 09:18: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)) 09:18: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)) 09:18: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)) 09:18: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)) 09:18: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)) 09:18: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)) 09:18: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)) 09:18: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)) 09:18: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)) 09:18: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)) 09:18:34 INFO - Cleaning up... 09:18:34 INFO - Return code: 0 09:18:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:18: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')]} 09:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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')]} 09:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18: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 0x7fc3a8748f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d9790>, '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 0x18da690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dab20>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', '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 09:18: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 09:18: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 09:18:34 INFO - Using env: {'DISPLAY': ':0', 09:18:34 INFO - 'HOME': '/home/cltbld', 09:18:34 INFO - 'LANG': 'en_US.UTF-8', 09:18:34 INFO - 'LANGUAGE': 'en_US:en', 09:18:34 INFO - 'LOGNAME': 'cltbld', 09:18:34 INFO - 'MAIL': '/var/mail/cltbld', 09:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:34 INFO - 'MOZ_NO_REMOTE': '1', 09:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:34 INFO - 'NO_EM_RESTART': '1', 09:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:34 INFO - 'PWD': '/builds/slave/test', 09:18:34 INFO - 'SHELL': '/bin/bash', 09:18:34 INFO - 'SHLVL': '1', 09:18:34 INFO - 'TERM': 'linux', 09:18:34 INFO - 'TMOUT': '86400', 09:18:34 INFO - 'USER': 'cltbld', 09:18:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', 09:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:34 INFO - '_': '/tools/buildbot/bin/python'} 09:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:18:34 INFO - Cleaning up... 09:18:34 INFO - Return code: 0 09:18:34 INFO - Running post-action listener: _resource_record_post_action 09:18:34 INFO - Running post-action listener: _start_resource_monitoring 09:18:34 INFO - Starting resource monitoring. 09:18:34 INFO - [mozharness: 2016-10-06 16:18:34.762502Z] Finished create-virtualenv step (success) 09:18:34 INFO - [mozharness: 2016-10-06 16:18:34.763221Z] Running install step. 09:18:34 INFO - Running pre-action listener: _resource_record_pre_action 09:18:34 INFO - Running main action method: install 09:18:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:34 INFO - Reading from file tmpfile_stdout 09:18:34 INFO - Detecting whether we're running mozinstall >=1.0... 09:18:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:18:35 INFO - Reading from file tmpfile_stdout 09:18:35 INFO - Output received: 09:18:35 INFO - Usage: mozinstall [options] installer 09:18:35 INFO - Options: 09:18:35 INFO - -h, --help show this help message and exit 09:18:35 INFO - -d DEST, --destination=DEST 09:18:35 INFO - Directory to install application into. [default: 09:18:35 INFO - "/builds/slave/test"] 09:18:35 INFO - --app=APP Application being installed. [default: firefox] 09:18:35 INFO - mkdir: /builds/slave/test/build/application 09:18:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:18:52 INFO - Reading from file tmpfile_stdout 09:18:52 INFO - Output received: 09:18:52 INFO - /builds/slave/test/build/application/firefox/firefox 09:18:52 INFO - Running post-action listener: _resource_record_post_action 09:18:52 INFO - [mozharness: 2016-10-06 16:18:52.083416Z] Finished install step (success) 09:18:52 INFO - [mozharness: 2016-10-06 16:18:52.083659Z] Running run-tests step. 09:18:52 INFO - Running pre-action listener: _resource_record_pre_action 09:18:52 INFO - Running main action method: run_tests 09:18:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:18:52 INFO - Python 2.7.3 09:18:52 INFO - Return code: 0 09:18:52 INFO - grabbing minidump binary from tooltool 09:18:52 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')]} 09:18:52 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 0x18d9790>, '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 0x18da690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:18:52 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 09:18:52 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 09:18:52 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 09:18:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:18:52 INFO - Return code: 0 09:18:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:18:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:18:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:18:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:18:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:18:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:18:52 INFO - Using env: {'DISPLAY': ':0', 09:18:52 INFO - 'HOME': '/home/cltbld', 09:18:52 INFO - 'LANG': 'en_US.UTF-8', 09:18:52 INFO - 'LANGUAGE': 'en_US:en', 09:18:52 INFO - 'LOGNAME': 'cltbld', 09:18:52 INFO - 'MAIL': '/var/mail/cltbld', 09:18:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:18:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:52 INFO - 'MOZ_NO_REMOTE': '1', 09:18:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:52 INFO - 'NO_EM_RESTART': '1', 09:18:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:52 INFO - 'PWD': '/builds/slave/test', 09:18:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:18:52 INFO - 'SHELL': '/bin/bash', 09:18:52 INFO - 'SHLVL': '1', 09:18:52 INFO - 'TERM': 'linux', 09:18:52 INFO - 'TMOUT': '86400', 09:18:52 INFO - 'USER': 'cltbld', 09:18:52 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777', 09:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:52 INFO - '_': '/tools/buildbot/bin/python'} 09:18:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:18:52 INFO - mozversion application_buildid: 20161006063000 09:18:52 INFO - mozversion application_changeset: 993bd0c52f8addd18cdf4163acd645e51090c679 09:18:52 INFO - mozversion application_display_name: Nightly 09:18:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:18:52 INFO - mozversion application_name: Firefox 09:18:52 INFO - mozversion application_remotingname: firefox 09:18:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:18:52 INFO - mozversion application_vendor: Mozilla 09:18:52 INFO - mozversion application_version: 52.0a1 09:18:52 INFO - mozversion platform_buildid: 20161006063000 09:18:52 INFO - mozversion platform_changeset: 993bd0c52f8addd18cdf4163acd645e51090c679 09:18:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:18:52 INFO - mozversion platform_version: 52.0a1 09:18:52 INFO - using testdate: 1475770732 09:18:52 INFO - actual date: 1475770732 09:18:52 INFO - starting webserver on 'localhost:43701' 09:18:52 INFO - SUITE-START | Running 2 tests 09:18:52 INFO - TEST-START | dromaeo_css 09:18:52 INFO - operating with platform_type : linux_ 09:18:52 INFO - Initialising browser for dromaeo_css test... 09:18:52 INFO - TEST-INFO | started process 12662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcg64dH/profile http://localhost:43701/getInfo.html) 09:18:56 INFO - PROCESS | 12662 | __metrics Screen width/height:1600/1200 09:18:56 INFO - PROCESS | 12662 | colorDepth:24 09:18:56 INFO - PROCESS | 12662 | Browser inner width/height: 1024/697 09:18:56 INFO - PROCESS | 12662 | __metrics 09:18:56 INFO - PROCESS | 12662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:18:56 INFO - PROCESS | 12662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:18:57 INFO - PROCESS | 12662 | console.error: PushService: 09:18:57 INFO - PROCESS | 12662 | stateChangeProcessEnqueue: Error transitioning state 09:18:57 INFO - PROCESS | 12662 | UnknownError 09:18:57 INFO - TEST-INFO | 12662: exit 0 09:18:57 INFO - Browser initialized. 09:18:57 INFO - Running cycle 1/1 for dromaeo_css test... 09:18:57 INFO - TEST-INFO | started process 12747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcg64dH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:10 INFO - PROCESS | 12747 | RSS: Main: 173645824 09:19:10 INFO - PROCESS | 12747 | 09:20:01 INFO - PROCESS | 12747 | 1475770801632 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] 09:22:11 INFO - PROCESS | 12747 | Cycle 1(1): loaded http://localhost:43701/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43701/tests/dromaeo/cssquery-ext.html) 09:22:13 INFO - PROCESS | 12747 | RSS: Main: 308420608 09:22:13 INFO - PROCESS | 12747 | 09:25:15 INFO - PROCESS | 12747 | Cycle 1(1): loaded http://localhost:43701/tests/dromaeo/cssquery-ext.html (next: http://localhost:43701/tests/dromaeo/cssquery-jquery.html) 09:25:16 INFO - PROCESS | 12747 | RSS: Main: 273387520 09:25:16 INFO - PROCESS | 12747 | 09:28:18 INFO - PROCESS | 12747 | Cycle 1(1): loaded http://localhost:43701/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43701/tests/dromaeo/cssquery-mootools.html) 09:28:19 INFO - PROCESS | 12747 | RSS: Main: 214564864 09:28:19 INFO - PROCESS | 12747 | 09:31:21 INFO - PROCESS | 12747 | Cycle 1(1): loaded http://localhost:43701/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43701/tests/dromaeo/cssquery-prototype.html) 09:31:21 INFO - PROCESS | 12747 | RSS: Main: 257548288 09:31:21 INFO - PROCESS | 12747 | 09:34:24 INFO - PROCESS | 12747 | Cycle 1(1): loaded http://localhost:43701/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43701/tests/dromaeo/cssquery-yui.html) 09:34:25 INFO - PROCESS | 12747 | RSS: Main: 214896640 09:34:25 INFO - PROCESS | 12747 | 09:37:27 INFO - PROCESS | 12747 | Cycle 1(1): loaded http://localhost:43701/tests/dromaeo/cssquery-yui.html (next: http://localhost:43701/tests/dromaeo/cssquery-dojo.html) 09:37:28 INFO - PROCESS | 12747 | RSS: Main: 305766400 09:37:28 INFO - PROCESS | 12747 | 09:37:28 INFO - PROCESS | 12747 | __start_tp_report 09:37:28 INFO - PROCESS | 12747 | _x_x_mozilla_page_load 09:37:28 INFO - PROCESS | 12747 | _x_x_mozilla_page_load_details 09:37:28 INFO - PROCESS | 12747 | |i|pagename|runs| 09:37:28 INFO - PROCESS | 12747 | |0;dojo.html;3019.909402717918;3052.4352994695982;3059.204606802231;3077.153782709753;3103.255218747501;5048.671836330636;5169;5264.710440925747;5316.3620365556135;5363.6245462817615;5298.4436634153435;5317;5368.46315368463;5374.247605335247;5478.58910581706;4828.73441960692;4883.658143929926;4883.780229889646;4901.06879692859;4953.380827396575;4986.601071914238;5023.698578085308;5028.120078986181;5029.094762942669;5065.1642478990925;4683.2975053741875;4731.384919960383;4733.621310295202;4922.21244600864;4936.01279744049;4782.521747825224;4785.64107691921;4811.975940120277;4815.975920120377;4858.732769697665;4773.4510531289;4796.760161991921;4806.49531799163;4819.44576373718;4864.878378040542;5341.2255222992835;5363;5381.219723140122;5386.757595908193;5386.946130538723;5502.422245664187;5539.14143307788;5555.138953462219;5650.886982260373;5734.913976290359;5726.885462290731;5747.4252574742195;5779.913301300484;5783.681897495636;5830.562707796932;5424.376196737387;5427.810026649048;5430.321209848769;5430.5927055471;5432.837014889559;5600.299962504687;5618.101103823368;5908.527317814564;5911.881762364728;5912.881742365129;5607.186957891165;5638.548916086703;5642.379338272869;5718.285214348207;5720.971395143081;5737.770489180386;5741.167530708024;5759.308882934075;5805.042168042226;5807.82576522705;5374.167004114369;5779.971100144472;5783;5792.4497172768515;5796.739146738407;5437.510624043855;5639.238702775155;5643.661380317194;5651.802186923438;5688.175214593861;4370.453693288339;4381.539938306496;4383.649308055348;4390.62679672225;4438.667099967515;3917.059905622687;3918.1380096378753;3947.585503522089;3980.0845805464905;3996.6003399659803;5206.479352064764;5263.210518422191;5418.972905135449;5461.5357694596405;5472.2338872557875;5735;5739.713014349266;5742.54059675225;5744.195812586241;5801.88396232073;5459.945400545944;5475.425080366584;5480.616356855062;5482.342118945752;5488.231647569343;4779.426468823764;4789.425268967677;4831.444383895897;4925.581325587365;5027.874303142451;5890.410958904075;5939.940600594025;5959.582829201914;5979.880402391927;5983.461488466059;5760.798372056958;5765.7117144141785;5765.8558536036935;5776.624519406225;5784.045632470596;5712.485876271156;5954.940450595439;5965.701714914324;5967.134765458897;5977.252843394575;5430.647007944471;5531.640443371168;5606.159076138611;5611.607187496836;5693.259876216231;5665.178549110274;5707.6290041147195;5711.685857277889;5715.771369145187;5724.942750572608;5549.334079910436;5556.138798486241;5560.833175004756;5564.55483561306;5568.359638641446;5346.759395827119;5462.098753705753;5530.087535556749;5551.722413879371;5589.748461319332;5527.419620939904;5576.386597474356;5622.3815380307315;5629.352624448077;5638.041532939328;5585.832425027255;5589.720513974366;5594.3286805581965;5601.159826026129;5608.747606357805;5306.54894333986;5316.415194328543;5476.863078423071;5494.340679118532;5548.472895074961 09:37:28 INFO - PROCESS | 12747 | |1;ext.html;552.113792932547;591.7248479457049;600.4055984575269;608.2883026858575;611.2420598457913;31578.368432631363;43072.784636076816;43969.34045989313;43975.78012109943;43982.340264895975;44591.554084459145;45112.0977580449;45161;45181;45219.77390113053;8008.719694810683;8203.58982050898;8733.91266087339;8943.686970956018;8945.686900958468;10445.529951152179;10638;10687.465626718633;10862.782744345148;10868.130549556055;10654.360738355685;10728.624498142566;10730.356178629307;10739.087177589876;10740.409277489734;8017.839643207161;8216.876746848802;10436.425996570186;10515.631952881651;10598.841017384706;10106.039926206999;10541.578336866516;10547.84178237327;10553.73615659607;10560.26078174528;41989.16021679549;42431.7878410606;42444.78777606123;42461.363079553834;42508.57491425108;3415.3852306584804;3432.1762776933606;3455.3262113887804;3478.3043391321835;3513.578370595545;31469.527957080663;31478.842605787053;31815.681843181734;31999.680003200137;32003.359932801213;4309.913801723948;4356.215881141393;4564.885877853047;4597;4613;290314;290811.54594227107;292497;294096;295368;35729.46405803915;57752.71123644355;58387.99999999915;58895.41104588985;58919.41080589225;37325.62674373222;37362.62637373646;37504.24991500155;37628.24743505169;37645.62354376476;13706.38321275545;13982.51061212873;13993.65015874591;14002.85997140036;14004.719905602034;9919.156871665846;10117.595296188218;10134.746631334276;10507.264491485676;11313.886861131448;8374.49753014821;8646.956765216133;8651.134886511298;8689.6524139035;8781.91218087811;3343.749218808599;3346.3140056288403;3421.4867769834723;3435.089701229176;3467.0465621954163;975.7658162041059;977.8777652793401;980.122790102854;981.7790997025755;1078.7464945737745;30067.248318792204;31250.84374578158;31386;31412.528812067838;31619.992201481644;1027.527337424793;1055.646358469921;1068.0921216965517;1120.0647459371517;1149.9305645749366;15047;16409.67180656404;16485;16744.24650890713;16758.24587893548;481774;492615;493653.317334139;493905;495216;55418.722906386014;55935.44064559302;55951;55986;56063.439365605824;1200.5137919142587;1239.8822111899356;1294.152330223705;1307.6926922173282;1340.7787715026911;27278;30744.846275769374;31396.215094622818;31869.20326991844;32354.676453235166;47943.28085078657;48161.75919120522;48601.513984861114;48637.27044094271;48673;360634;360824;362068;362816;362939;27247.45505089927;28465.715342846306;28536;29561.704382955893;29608;45384.77307613441;46251.53748462607;46545.76727116343;46653.76673116613;47127;38816.41775373315;39197;39473.40789888211;39496.210075798896;41009.38485922654;37391.25217495689;37669;37735.81132094322;38011.809940950116;38526.42210366903;38483.230335393695;39012;39632.801835990635;39851.60148398479;39873.60126398699;32039.359212815147;34453;34574.82712586421;35634;36370;26074.348141296618;27397.58903616487;27434.725652744015;27598.862005689843;27893.44213115767 09:37:28 INFO - PROCESS | 12747 | |2;jquery.html;369.6765330335956;398.3765407137829;399.8440608162816;402.2879503279196;427.6835141994925;13374.264415457146;15356.385744570218;18994.525136871584;19377.128029238684;19632.999999999964;18953.810461895377;19088.71366929497;19312.903435482804;19534.60930781387;19585.412437626896;5573.191887176357;5828.941710582903;5883.411658834125;5884.440978107073;5891.851089037639;5987.730552125143;6144.6006009609455;6148.938510614904;6149.29283132441;6155.230596175478;3997.580254073324;4190.832366705328;5826.621269617462;6019.277686677605;6025.879482410349;5864.76540938362;6025.397460253984;6078.361772013941;6088.117223002662;6101.054336577838;5862.677552734598;5906.3798301178185;5910.231669882931;5913.970430147821;5914.497267732248;14353.138811671333;18530.62938741231;22595.661065084038;23187.53624927509;23352.883235583882;2269.262489690857;2296.4603318220206;2396.1493669747338;2432.221689059502;2532.3669082729316;10170;10256.384616922935;10260.589576416935;10810.513526891309;10820.621278255223;1767.142935676196;1861.3857427049177;1885.7831349394858;1893.0818553001784;1914.0716752375088;81987.88193889009;83248.58375708143;83631.581842091;84308.99999999939;86888;10557.9472102639;10779.407132607781;11031.393273369882;11094.22340436178;11149.498272577754;15638;15761.29074191664;15771.132587707787;15798.763018554731;15820.76268855968;7479.364254038359;7742.0064058682965;7842.843143137219;7947.841043179104;8015.719449819228;7388.778336649909;7441.85116297671;7443.776686699408;7645.4648174628355;7721.382289416833;4714.45783734868;4742.288656701453;4755.38180036593;4865.537773911473;4960.454350021495;1925.9903700481689;1954.4136758972252;2010.7687615924062;2017.5258814178655;2020.40398082566;853.2150421612132;904.3036861616519;904.9142424332993;916.4501299220415;989.2135752077116;17056.147192640317;18169.909150454165;18760.343387981356;18929.24283028691;18978.335758248395;979.5787811241092;983.1495756171004;993.6869885985891;1011.1304278320786;1041.578160844859;9342.813143737087;10178.643747468803;10479.266451348332;10522.631707890187;10593.735156621146;410647;412899;418995;428632;428731;66211;76761;76845;79802.60098699469;88150.11849881547;950.0594411532533;966.0677446264389;986.6891929042329;987.7234374375187;991.0832479956011;16352.100634465218;16776;16964;17247.56881077933;17289.740653890454;37501.62485376329;39707.40438893361;39979.2004159921;40225.59774402218;41528.1694366117;48819.75590122027;50885;51906.22140667969;52481.21278180907;54208.45791542034;7394.186639469546;7800.492967957065;8128.3497320213055;8342.457740246864;8451.535165565952;8107.878381824396;10147.036031576989;12332.383380831103;13184.802227966396;13243.470261189444;7949.3243074337015;10116.848247276444;11667.59163429276;11803.114766392726;11816.940915295369;11236.213465057368;11353.318800871974;11362.659120226406;11462.312261264351;11545.653630391102;11384.203105782515;11576.146002571377;11644.2431241969;12088.15382923187;12219.69450763738;7724.536527808349;7793.337566306927;7872.488288261474;8129.512229266263;8162.42862999608;10083.848742269018;11356.488957996744;11369.715757106138;11751.941240294085;11932.701682458008 09:37:28 INFO - PROCESS | 12747 | |3;mootools.html;1475.2623688155923;1502.9473968411107;1644.8684105271573;1783.2064731194623;1811.1125548481248;8052.4765890217095;8381.371397145223;8739.388242822997;9423.905760942396;9428.71713848584;8766.211041006309;9079.727608171748;9095.954520227406;9214.170724634781;9235.722928312161;2361.929142125735;2390.521895620874;2392.222527678503;2395.808335333178;2396.808255339569;1939.76722793265;2005.7392538969914;2262.875541845198;2285.1544928376525;2332.918347857825;2358.716953965518;2400.711914570254;2400.939976500584;2411.505641343529;2413.1795189635523;2341.7072865891764;2342.227065068523;2352.329586067971;2386.1648423051965;2391.5336509380677;2292.5529521743265;2340.9648855267183;2348.0607756897207;2348.5537747827857;2363.7163540375095;9147.771305717344;9147.817043659155;9203.53982300889;9226.354155209137;9241.075892410705;5361.490658387447;5481.862953426156;5527.143292789624;5537.723113844291;5543.805966791183;3479.4780782882517;3547.130952916552;3625.5105560749225;3626.5104210931713;3658.487811706363;1127.4419162514525;1137.8805225451374;1157.7395086105644;1187.424099311833;1199.3643369014437;13152.934235328858;13153.473861045546;13176.275304858229;13195.670108247275;13225.470981160743;4546.931796023062;4704.9529504704515;4796.448408433005;4864.464908860094;4891.241857512091;10969.890301097046;10978.066864316463;11005.229633925548;11007.944960275308;11013.83479247796;5444.754986025639;5451.373092094381;5456.263404440429;5460.972695136499;5465.535429488458;4762.3808904842845;4848;5017.67385119966;5019.67372120811;5024.748762561857;3633.927321453556;3647.854085836537;3689.3912504437003;3701.759385639925;3752.3058234226755;1028.8662473878348;1030.217035053365;1068.8022715797601;1089.8201796703613;1104.4036220441033;821.199330652609;926.4117285523741;929.9116583924516;945.8061097475002;950.5152372290182;5934.910976335358;5975.2373049950365;6024.969875150684;6152.3540028297275;6196.81409557714;952.3333666433524;963.21016766251;966.6471737815647;973.9026097390205;999;3997.420374045805;4084.4485994390375;4088.2232375848494;4114.7942602870335;4208.494980602286;11307;11519.136064795173;11602.419879006016;11657.125715571197;11663.941680291713;10772;11312;11500.482478288497;11520.078393728481;11561.942190288995;8370.916290837136;8575.099614540508;8579.099194584604;8586.184312490428;8592.613332400057;5929.644221346733;6005.279366476051;6066.636001839727;6317.872628187293;6325.399087086904;10098;10516.68449946503;10669.306495077795;10705.89294107049;10711.732206694895;10403.947980260353;10647.680569582924;10856.077233435246;10965.342079474938;10986.340819550853;7930.722424715107;8027.638756256099;8038.758837234892;8043.034835819739;8047.0745864226365;8813.515256660688;8879.422837515542;8882.333824963283;8895.688650897446;8897.110288971051;7617.771466856003;7955.602219888867;8057.677692892219;8110.837783244184;8170.060443049126;7831.84336313282;7860.135385107748;7878.172791856772;8007.079185893696;8089.110197878346;6721.529492935643;6789.388954994074;6793.218779840184;6905.240423553305;7070.04554385172;4998.875028124326;5073.695578265316;5157.355330583677;5243.449437808975;5320.255164276927;5163.122269214317;5239.109351410346;5274.375062244766;5306.787728490817;5322.707251101072 09:37:28 INFO - PROCESS | 12747 | |4;prototype.html;328.1337269608235;330.91892486340845;337.40111302438174;339.7774457730186;343.24999875272545;5358.732063396829;5420.9186862197;5432.429594892538;5453.318335208099;5462.170172992048;5094.261332106842;5217.921731174036;5229.267902493654;5342.252084708134;5380.892382152364;4224.408582798411;4229.725067870579;4254.446921900164;4258.913976935893;4275.294576394891;4236.57634236577;4245.426867372911;4246.27813271743;4249.44757181566;4251.744895306291;4061.6547593454593;4164.354525048622;4170.70805043647;4177.248095342837;4182.665386769051;4142.958570414317;4164.292070348018;4164.312888373414;4174.457320548325;4195.4336164618;3669.6513831185994;3677.7793332400142;3680.208755117636;3687.1519550503267;3688.5942546319884;5014;5217.713025783581;5220.3735551734035;5228.189630607262;5232.241325007891;4751.384529260068;4769.689970151929;4769.856904292877;4772.637544415502;4776.307435421879;5612.887742245132;5625.38120806711;5628.240187574707;5642.717864106819;5652.576056795716;3923.7836270756156;3996.360582306817;4023.155137421145;4046.433499310099;4052.4124002019544;5816.88366232673;5852.4440178183;5855.355910849803;5889.499392551638;5890.705464726747;4078.327076032481;4080.591940805896;4080.9795951020646;4092.1201941582704;4095.119549296856;3955.8417663293144;4109.3425051991535;4114.786138089271;4131.215069136854;4137.3243836246365;4713.6464765142755;4738.19450693383;4739.786709598076;4747.715137091716;4758;5668.659880407189;5671.234383358276;5677.517411020027;5677.801276955287;5686.2323586315315;1392.8328600567997;1426.686129051607;1438.978415323771;1445.551878917539;1449.948787129323;898.0749827677503;910.526526206369;922.1239822168966;922.2667978956746;922.7831459606987;4874.830700338386;4891.902161956741;4901.607871370282;4910.477751896923;4915.901681966412;5119.385673719103;5137.691738495628;5162.225666150108;5166.741662916839;5170.767315470813;4441.489893436247;4783.832565860178;4795.434442573207;4801.279808028824;4817.855464336076;2678.5758888206205;2679.2632026192955;2692.3942113024805;2695.2588038289628;2702.8108032437935;5134.486551344836;5160.277561141444;5188.533032027136;5198.972400763705;5219.19102539107;4746.359241502422;5101.591872650179;5105.412877519058;5123.462036486189;5151.871203219949;5153.788859618062;5163.463027825951;5170.1986192140275;5190.558802501754;5203.245529398292;4951.762059485129;4981.775820088177;5027.019731152536;5063.544281014726;5077.543021128116;4790.520947905321;5011.070737766059;5028.371453568304;5041;5069.437506244262;5268.341457317835;5283.203710738214;5283.524482796567;5295.76169072385;5302.825841405005;3754.4231422803036;3759.8308076137187;3765.378712512405;3782.432635104756;3862.4978752761963;5593.916091258553;5619.634723742944;5766.192733017297;5769.59612827098;5779.913301300568;5522.502974732132;5569.415211402907;5576.944230557642;5582.469665381782;5593.692346920959;5340.49265319794;5568.470995255444;5577.609567330248;5588.981949747254;5620.718964051863;5604.887902242014;5612.8877422450505;5613.270274864241;5613.522850557748;5620.325560932551;5603.487058494102;5611.2424822650055;5611.438856114356;5631.577631677723;5645.125005624135;5265.657732247391;5505.862353441035;5534.944650553604;5538.695371754592;5542.944570554243 09:37:28 INFO - PROCESS | 12747 | |5;yui.html;721.2787212787213;739.142594590275;776.8951191589134;798.9280964713176;840.5965136734371;15365.078095314275;16031;16069;16148.515544533682;16207.270672819723;15470.61323466914;15546.76679849803;15548.222588870567;15600.843991560081;15674.451394201205;652.3378770547874;686.2862622872207;802.542550746075;823.8558252305822;827.8137419080689;772.1737740617541;804.9396295277849;805.1465446626565;809.7773112394079;814.975550733476;848.2620120495147;853.3471894001094;854.2055888024136;855.102142750113;858.9828203435927;676.4723515657795;848.2238751542332;849.8852654891604;857.5883575883548;857.8284343131368;515.4973900447071;597.0298265318856;617.9443850053517;619.2043224456596;620.6710443464971;14556.417743290256;14574.417023319054;14577.562673119823;14590.489332873298;14596.416143354252;13461.528846490326;13969.092009019381;14233.928830355782;14393.35229914646;14469;12890.80663790044;13124.648864184384;13265.734685306335;13344.799828002491;13510.932445337809;4404.779761011969;4412.448443944507;4417.491988421309;4515.322701594754;4580.541945805426;77170.6141469289;79184.81222781721;79256;79318.6034069826;80466.19533804645;11299.943500282447;11336.546538138547;11465.656030319104;11499.827502587468;11660.70848228784;18964.14661340243;19845.4046378606;19991.300304489272;20553.58892822135;20655.896720516303;8102.473339233049;8195.262426381654;8217.424780265324;8327.167283271625;8554.144585541397;4699.929501057487;4775.737334446639;4787.305840653085;4791.329213910055;4854.538818812207;3571.946420803638;3705.5182826232417;3711.628837116267;3712.7215458840697;3722.1389305347325;651.1177354684429;651.6969609131777;655.1221363373103;667.1693741292122;667.6861874918781;666.4980585268577;676.5872817581271;711.4379640084379;743.6690672650618;757.1973707869676;9594.1365277124;9630.2777291702;10047.555298019837;10268.794624107626;10291.948540257401;567.7927556441952;591.5829340315067;721.8917162425678;724.4530379563502;728.4172661870482;4487.4839393470165;4699.130660827758;4709.929351059737;4720.811167553328;4751.453582838018;68783.31216687869;70055.29944700589;76054.61972690212;123910;127338;80877.59561202273;82453.58773206096;106277.46861265645;108805.20753132098;110616.4469177665;52483.73758131185;63895.68052159803;75178;75995.24004759992;82308;9337.953310233406;9882.160016398686;9884.505774711091;9977.750556235862;10112.59549618007;47453;48234.758826205645;48694.26958595553;49766.751166243936;50242.49757502378;65540;66474;72642.63678681572;73442.63278683572;74387;12417.813732793835;12572.245665260114;12921.418536166084;13179.472821087049;13522.86477135216;14314;14498.275086245856;14675.92662036683;15292.31184596718;15474.14892180896;10587.682369528926;13263.80104298417;13634.250116243702;13697.383617737027;15064.623384415478;13740.312984350943;14039.859601403856;14109.647258818612;14129.222892740998;14608.196549189897;12936.611901642966;13459.259740714355;13532.188068715908;13784.172949623055;14063.929680351943;10804.837927430937;10975.50610222526;11533.423328833693;11623.070154387799;11969.700757481132;10991.450427478434;11285.887141128484;11797.941010294893;11813.822792657946;11960 09:37:28 INFO - PROCESS | 12747 | __end_tp_report 09:37:28 INFO - PROCESS | 12747 | __start_cc_report 09:37:28 INFO - PROCESS | 12747 | _x_x_mozilla_cycle_collect,1197 09:37:28 INFO - PROCESS | 12747 | __end_cc_report 09:37:28 INFO - PROCESS | 12747 | __startTimestamp1475771848204__endTimestamp 09:37:28 INFO - PROCESS | 12747 | 09:37:28 INFO - PROCESS | 12747 | ------- Summary: start ------- 09:37:28 INFO - PROCESS | 12747 | Number of tests: 6 09:37:28 INFO - PROCESS | 12747 | 09:37:28 INFO - PROCESS | 12747 | [#0] dojo.html Cycles:165 Average:5306.78 Median:5488.23 stddev:603.96 (11.0%) stddev-sans-first:578.55 09:37:28 INFO - PROCESS | 12747 | Values: 3019.9 3052.4 3059.2 3077.2 3103.3 5048.7 5169.0 5264.7 5316.4 5363.6 5298.4 5317.0 5368.5 5374.2 5478.6 4828.7 4883.7 4883.8 4901.1 4953.4 4986.6 5023.7 5028.1 5029.1 5065.2 4683.3 4731.4 4733.6 4922.2 4936.0 4782.5 4785.6 4812.0 4816.0 4858.7 4773.5 4796.8 4806.5 4819.4 4864.9 5341.2 5363.0 5381.2 5386.8 5386.9 5502.4 5539.1 5555.1 5650.9 5734.9 5726.9 5747.4 5779.9 5783.7 5830.6 5424.4 5427.8 5430.3 5430.6 5432.8 5600.3 5618.1 5908.5 5911.9 5912.9 5607.2 5638.5 5642.4 5718.3 5721.0 5737.8 5741.2 5759.3 5805.0 5807.8 5374.2 5780.0 5783.0 5792.4 5796.7 5437.5 5639.2 5643.7 5651.8 5688.2 4370.5 4381.5 4383.6 4390.6 4438.7 3917.1 3918.1 3947.6 3980.1 3996.6 5206.5 5263.2 5419.0 5461.5 5472.2 5735.0 5739.7 5742.5 5744.2 5801.9 5459.9 5475.4 5480.6 5482.3 5488.2 4779.4 4789.4 4831.4 4925.6 5027.9 5890.4 5939.9 5959.6 5979.9 5983.5 5760.8 5765.7 5765.9 5776.6 5784.0 5712.5 5954.9 5965.7 5967.1 5977.3 5430.6 5531.6 5606.2 5611.6 5693.3 5665.2 5707.6 5711.7 5715.8 5724.9 5549.3 5556.1 5560.8 5564.6 5568.4 5346.8 5462.1 5530.1 5551.7 5589.7 5527.4 5576.4 5622.4 5629.4 5638.0 5585.8 5589.7 5594.3 5601.2 5608.7 5306.5 5316.4 5476.9 5494.3 5548.5 09:37:28 INFO - PROCESS | 12747 | 09:37:28 INFO - PROCESS | 12747 | [#1] ext.html Cycles:180 Average:53676.22 Median:361446.00 stddev:103485.76 (28.6%) stddev-sans-first:103699.19 09:37:28 INFO - PROCESS | 12747 | Values: 552.1 591.7 600.4 608.3 611.2 31578.4 43072.8 43969.3 43975.8 43982.3 44591.6 45112.1 45161.0 45181.0 45219.8 8008.7 8203.6 8733.9 8943.7 8945.7 10445.5 10638.0 10687.5 10862.8 10868.1 10654.4 10728.6 10730.4 10739.1 10740.4 8017.8 8216.9 10436.4 10515.6 10598.8 10106.0 10541.6 10547.8 10553.7 10560.3 41989.2 42431.8 42444.8 42461.4 42508.6 3415.4 3432.2 3455.3 3478.3 3513.6 31469.5 31478.8 31815.7 31999.7 32003.4 4309.9 4356.2 4564.9 4597.0 4613.0 290314.0 290811.5 292497.0 294096.0 295368.0 35729.5 57752.7 58388.0 58895.4 58919.4 37325.6 37362.6 37504.2 37628.2 37645.6 13706.4 13982.5 13993.7 14002.9 14004.7 9919.2 10117.6 10134.7 10507.3 11313.9 8374.5 8647.0 8651.1 8689.7 8781.9 3343.7 3346.3 3421.5 3435.1 3467.0 975.8 977.9 980.1 981.8 1078.7 30067.2 31250.8 31386.0 31412.5 31620.0 1027.5 1055.6 1068.1 1120.1 1149.9 15047.0 16409.7 16485.0 16744.2 16758.2 481774.0 492615.0 493653.3 493905.0 495216.0 55418.7 55935.4 55951.0 55986.0 56063.4 1200.5 1239.9 1294.2 1307.7 1340.8 27278.0 30744.8 31396.2 31869.2 32354.7 47943.3 48161.8 48601.5 48637.3 48673.0 360634.0 360824.0 362068.0 362816.0 362939.0 27247.5 28465.7 28536.0 29561.7 29608.0 45384.8 46251.5 46545.8 46653.8 47127.0 38816.4 39197.0 39473.4 39496.2 41009.4 37391.3 37669.0 37735.8 38011.8 38526.4 38483.2 39012.0 39632.8 39851.6 39873.6 32039.4 34453.0 34574.8 35634.0 36370.0 26074.3 27397.6 27434.7 27598.9 27893.4 09:37:28 INFO - PROCESS | 12747 | 09:37:28 INFO - PROCESS | 12747 | [#2] jquery.html Cycles:180 Average:26221.24 Median:20190.74 stddev:69412.62 (343.8%) stddev-sans-first:69580.20 09:37:28 INFO - PROCESS | 12747 | Values: 369.7 398.4 399.8 402.3 427.7 13374.3 15356.4 18994.5 19377.1 19633.0 18953.8 19088.7 19312.9 19534.6 19585.4 5573.2 5828.9 5883.4 5884.4 5891.9 5987.7 6144.6 6148.9 6149.3 6155.2 3997.6 4190.8 5826.6 6019.3 6025.9 5864.8 6025.4 6078.4 6088.1 6101.1 5862.7 5906.4 5910.2 5914.0 5914.5 14353.1 18530.6 22595.7 23187.5 23352.9 2269.3 2296.5 2396.1 2432.2 2532.4 10170.0 10256.4 10260.6 10810.5 10820.6 1767.1 1861.4 1885.8 1893.1 1914.1 81987.9 83248.6 83631.6 84309.0 86888.0 10557.9 10779.4 11031.4 11094.2 11149.5 15638.0 15761.3 15771.1 15798.8 15820.8 7479.4 7742.0 7842.8 7947.8 8015.7 7388.8 7441.9 7443.8 7645.5 7721.4 4714.5 4742.3 4755.4 4865.5 4960.5 1926.0 1954.4 2010.8 2017.5 2020.4 853.2 904.3 904.9 916.5 989.2 17056.1 18169.9 18760.3 18929.2 18978.3 979.6 983.1 993.7 1011.1 1041.6 9342.8 10178.6 10479.3 10522.6 10593.7 410647.0 412899.0 418995.0 428632.0 428731.0 66211.0 76761.0 76845.0 79802.6 88150.1 950.1 966.1 986.7 987.7 991.1 16352.1 16776.0 16964.0 17247.6 17289.7 37501.6 39707.4 39979.2 40225.6 41528.2 48819.8 50885.0 51906.2 52481.2 54208.5 7394.2 7800.5 8128.3 8342.5 8451.5 8107.9 10147.0 12332.4 13184.8 13243.5 7949.3 10116.8 11667.6 11803.1 11816.9 11236.2 11353.3 11362.7 11462.3 11545.7 11384.2 11576.1 11644.2 12088.2 12219.7 7724.5 7793.3 7872.5 8129.5 8162.4 10083.8 11356.5 11369.7 11751.9 11932.7 09:37:28 INFO - PROCESS | 12747 | 09:37:28 INFO - PROCESS | 12747 | [#3] mootools.html Cycles:180 Average:5991.02 Median:4877.85 stddev:3502.55 (71.8%) stddev-sans-first:3495.94 09:37:28 INFO - PROCESS | 12747 | Values: 1475.3 1502.9 1644.9 1783.2 1811.1 8052.5 8381.4 8739.4 9423.9 9428.7 8766.2 9079.7 9096.0 9214.2 9235.7 2361.9 2390.5 2392.2 2395.8 2396.8 1939.8 2005.7 2262.9 2285.2 2332.9 2358.7 2400.7 2400.9 2411.5 2413.2 2341.7 2342.2 2352.3 2386.2 2391.5 2292.6 2341.0 2348.1 2348.6 2363.7 9147.8 9147.8 9203.5 9226.4 9241.1 5361.5 5481.9 5527.1 5537.7 5543.8 3479.5 3547.1 3625.5 3626.5 3658.5 1127.4 1137.9 1157.7 1187.4 1199.4 13152.9 13153.5 13176.3 13195.7 13225.5 4546.9 4705.0 4796.4 4864.5 4891.2 10969.9 10978.1 11005.2 11007.9 11013.8 5444.8 5451.4 5456.3 5461.0 5465.5 4762.4 4848.0 5017.7 5019.7 5024.7 3633.9 3647.9 3689.4 3701.8 3752.3 1028.9 1030.2 1068.8 1089.8 1104.4 821.2 926.4 929.9 945.8 950.5 5934.9 5975.2 6025.0 6152.4 6196.8 952.3 963.2 966.6 973.9 999.0 3997.4 4084.4 4088.2 4114.8 4208.5 11307.0 11519.1 11602.4 11657.1 11663.9 10772.0 11312.0 11500.5 11520.1 11561.9 8370.9 8575.1 8579.1 8586.2 8592.6 5929.6 6005.3 6066.6 6317.9 6325.4 10098.0 10516.7 10669.3 10705.9 10711.7 10403.9 10647.7 10856.1 10965.3 10986.3 7930.7 8027.6 8038.8 8043.0 8047.1 8813.5 8879.4 8882.3 8895.7 8897.1 7617.8 7955.6 8057.7 8110.8 8170.1 7831.8 7860.1 7878.2 8007.1 8089.1 6721.5 6789.4 6793.2 6905.2 7070.0 4998.9 5073.7 5157.4 5243.4 5320.3 5163.1 5239.1 5274.4 5306.8 5322.7 09:37:28 INFO - PROCESS | 12747 | 09:37:28 INFO - PROCESS | 12747 | [#4] prototype.html Cycles:180 Average:4538.16 Median:5073.49 stddev:1313.05 (25.9%) stddev-sans-first:1278.15 09:37:28 INFO - PROCESS | 12747 | Values: 328.1 330.9 337.4 339.8 343.2 5358.7 5420.9 5432.4 5453.3 5462.2 5094.3 5217.9 5229.3 5342.3 5380.9 4224.4 4229.7 4254.4 4258.9 4275.3 4236.6 4245.4 4246.3 4249.4 4251.7 4061.7 4164.4 4170.7 4177.2 4182.7 4143.0 4164.3 4164.3 4174.5 4195.4 3669.7 3677.8 3680.2 3687.2 3688.6 5014.0 5217.7 5220.4 5228.2 5232.2 4751.4 4769.7 4769.9 4772.6 4776.3 5612.9 5625.4 5628.2 5642.7 5652.6 3923.8 3996.4 4023.2 4046.4 4052.4 5816.9 5852.4 5855.4 5889.5 5890.7 4078.3 4080.6 4081.0 4092.1 4095.1 3955.8 4109.3 4114.8 4131.2 4137.3 4713.6 4738.2 4739.8 4747.7 4758.0 5668.7 5671.2 5677.5 5677.8 5686.2 1392.8 1426.7 1439.0 1445.6 1449.9 898.1 910.5 922.1 922.3 922.8 4874.8 4891.9 4901.6 4910.5 4915.9 5119.4 5137.7 5162.2 5166.7 5170.8 4441.5 4783.8 4795.4 4801.3 4817.9 2678.6 2679.3 2692.4 2695.3 2702.8 5134.5 5160.3 5188.5 5199.0 5219.2 4746.4 5101.6 5105.4 5123.5 5151.9 5153.8 5163.5 5170.2 5190.6 5203.2 4951.8 4981.8 5027.0 5063.5 5077.5 4790.5 5011.1 5028.4 5041.0 5069.4 5268.3 5283.2 5283.5 5295.8 5302.8 3754.4 3759.8 3765.4 3782.4 3862.5 5593.9 5619.6 5766.2 5769.6 5779.9 5522.5 5569.4 5576.9 5582.5 5593.7 5340.5 5568.5 5577.6 5589.0 5620.7 5604.9 5612.9 5613.3 5613.5 5620.3 5603.5 5611.2 5611.4 5631.6 5645.1 5265.7 5505.9 5534.9 5538.7 5542.9 09:37:28 INFO - PROCESS | 12747 | 09:37:28 INFO - PROCESS | 12747 | [#5] yui.html Cycles:180 Average:19676.23 Median:4699.53 stddev:27470.36 (584.5%) stddev-sans-first:27510.55 09:37:28 INFO - PROCESS | 12747 | Values: 721.3 739.1 776.9 798.9 840.6 15365.1 16031.0 16069.0 16148.5 16207.3 15470.6 15546.8 15548.2 15600.8 15674.5 652.3 686.3 802.5 823.9 827.8 772.2 804.9 805.1 809.8 815.0 848.3 853.3 854.2 855.1 859.0 676.5 848.2 849.9 857.6 857.8 515.5 597.0 617.9 619.2 620.7 14556.4 14574.4 14577.6 14590.5 14596.4 13461.5 13969.1 14233.9 14393.4 14469.0 12890.8 13124.6 13265.7 13344.8 13510.9 4404.8 4412.4 4417.5 4515.3 4580.5 77170.6 79184.8 79256.0 79318.6 80466.2 11299.9 11336.5 11465.7 11499.8 11660.7 18964.1 19845.4 19991.3 20553.6 20655.9 8102.5 8195.3 8217.4 8327.2 8554.1 4699.9 4775.7 4787.3 4791.3 4854.5 3571.9 3705.5 3711.6 3712.7 3722.1 651.1 651.7 655.1 667.2 667.7 666.5 676.6 711.4 743.7 757.2 9594.1 9630.3 10047.6 10268.8 10291.9 567.8 591.6 721.9 724.5 728.4 4487.5 4699.1 4709.9 4720.8 4751.5 68783.3 70055.3 76054.6 123910.0 127338.0 80877.6 82453.6 106277.5 108805.2 110616.4 52483.7 63895.7 75178.0 75995.2 82308.0 9338.0 9882.2 9884.5 9977.8 10112.6 47453.0 48234.8 48694.3 49766.8 50242.5 65540.0 66474.0 72642.6 73442.6 74387.0 12417.8 12572.2 12921.4 13179.5 13522.9 14314.0 14498.3 14675.9 15292.3 15474.1 10587.7 13263.8 13634.3 13697.4 15064.6 13740.3 14039.9 14109.6 14129.2 14608.2 12936.6 13459.3 13532.2 13784.2 14063.9 10804.8 10975.5 11533.4 11623.1 11969.7 10991.5 11285.9 11797.9 11813.8 11960.0 09:37:28 INFO - PROCESS | 12747 | -------- Summary: end -------- 09:37:28 INFO - PROCESS | 12747 | 09:37:29 INFO - TEST-INFO | 12747: exit 0 09:37:29 INFO - TEST-OK | dromaeo_css | took 1116772ms 09:37:29 INFO - TEST-START | kraken 09:37:29 INFO - operating with platform_type : linux_ 09:37:29 INFO - Initialising browser for kraken test... 09:37:29 INFO - TEST-INFO | started process 13051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0qefuh/profile http://localhost:43701/getInfo.html) 09:37:32 INFO - PROCESS | 13051 | __metrics Screen width/height:1600/1200 09:37:32 INFO - PROCESS | 13051 | colorDepth:24 09:37:32 INFO - PROCESS | 13051 | Browser inner width/height: 1024/697 09:37:32 INFO - PROCESS | 13051 | __metrics 09:37:33 INFO - PROCESS | 13051 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:37:33 INFO - PROCESS | 13051 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:37:33 INFO - PROCESS | 13051 | console.error: PushService: 09:37:33 INFO - PROCESS | 13051 | stateChangeProcessEnqueue: Error transitioning state 09:37:33 INFO - PROCESS | 13051 | UnknownError 09:37:34 INFO - TEST-INFO | 13051: exit 0 09:37:34 INFO - Browser initialized. 09:37:34 INFO - Running cycle 1/1 for kraken test... 09:37:34 INFO - TEST-INFO | started process 13132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0qefuh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:37:46 INFO - PROCESS | 13132 | RSS: Main: 174649344 09:37:46 INFO - PROCESS | 13132 | 09:37:49 INFO - PROCESS | 13132 | Cycle 1(1): loaded http://localhost:43701/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43701/tests/kraken/driver.html?testName=audio-beat-detection) 09:37:50 INFO - PROCESS | 13132 | RSS: Main: 232800256 09:37:50 INFO - PROCESS | 13132 | 09:37:52 INFO - PROCESS | 13132 | Cycle 1(1): loaded http://localhost:43701/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43701/tests/kraken/driver.html?testName=audio-dft) 09:37:53 INFO - PROCESS | 13132 | RSS: Main: 217186304 09:37:53 INFO - PROCESS | 13132 | 09:37:56 INFO - PROCESS | 13132 | Cycle 1(1): loaded http://localhost:43701/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43701/tests/kraken/driver.html?testName=audio-fft) 09:37:57 INFO - PROCESS | 13132 | RSS: Main: 299368448 09:37:57 INFO - PROCESS | 13132 | 09:37:59 INFO - PROCESS | 13132 | Cycle 1(1): loaded http://localhost:43701/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43701/tests/kraken/driver.html?testName=audio-oscillator) 09:37:59 INFO - PROCESS | 13132 | RSS: Main: 210198528 09:37:59 INFO - PROCESS | 13132 | 09:38:02 INFO - PROCESS | 13132 | Cycle 1(1): loaded http://localhost:43701/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43701/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:38:02 INFO - PROCESS | 13132 | RSS: Main: 213811200 09:38:02 INFO - PROCESS | 13132 | 09:38:05 INFO - PROCESS | 13132 | Cycle 1(1): loaded http://localhost:43701/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43701/tests/kraken/driver.html?testName=imaging-darkroom) 09:38:06 INFO - PROCESS | 13132 | RSS: Main: 250585088 09:38:06 INFO - PROCESS | 13132 | 09:38:09 INFO - PROCESS | 13132 | Cycle 1(1): loaded http://localhost:43701/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43701/tests/kraken/driver.html?testName=imaging-desaturate) 09:38:10 INFO - PROCESS | 13132 | RSS: Main: 248893440 09:38:10 INFO - PROCESS | 13132 | 09:38:13 INFO - PROCESS | 13132 | Cycle 1(1): loaded http://localhost:43701/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43701/tests/kraken/driver.html?testName=json-parse-financial) 09:38:13 INFO - PROCESS | 13132 | RSS: Main: 248418304 09:38:13 INFO - PROCESS | 13132 | 09:38:15 INFO - PROCESS | 13132 | Cycle 1(1): loaded http://localhost:43701/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43701/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:38:15 INFO - PROCESS | 13132 | RSS: Main: 210481152 09:38:15 INFO - PROCESS | 13132 | 09:38:17 INFO - PROCESS | 13132 | Cycle 1(1): loaded http://localhost:43701/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43701/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:38:18 INFO - PROCESS | 13132 | RSS: Main: 218513408 09:38:18 INFO - PROCESS | 13132 | 09:38:20 INFO - PROCESS | 13132 | Cycle 1(1): loaded http://localhost:43701/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43701/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:38:20 INFO - PROCESS | 13132 | RSS: Main: 227434496 09:38:20 INFO - PROCESS | 13132 | 09:38:23 INFO - PROCESS | 13132 | Cycle 1(1): loaded http://localhost:43701/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:38:24 INFO - PROCESS | 13132 | RSS: Main: 236060672 09:38:24 INFO - PROCESS | 13132 | 09:38:27 INFO - PROCESS | 13132 | Cycle 1(1): loaded http://localhost:43701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:38:27 INFO - PROCESS | 13132 | RSS: Main: 232935424 09:38:27 INFO - PROCESS | 13132 | 09:38:29 INFO - PROCESS | 13132 | Cycle 1(1): loaded http://localhost:43701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43701/tests/kraken/driver.html?testName=ai-astar) 09:38:29 INFO - PROCESS | 13132 | RSS: Main: 282525696 09:38:29 INFO - PROCESS | 13132 | 09:38:29 INFO - PROCESS | 13132 | __start_tp_report 09:38:29 INFO - PROCESS | 13132 | _x_x_mozilla_page_load 09:38:29 INFO - PROCESS | 13132 | _x_x_mozilla_page_load_details 09:38:29 INFO - PROCESS | 13132 | |i|pagename|runs| 09:38:29 INFO - PROCESS | 13132 | |0;ai-astar;112;111;111;112;111;111;110;112;111;111 09:38:29 INFO - PROCESS | 13132 | |1;audio-beat-detection;153;128;124;166;125;123;122;128;157;125 09:38:29 INFO - PROCESS | 13132 | |2;audio-dft;162;161;165;161;163;162;162;165;162;163 09:38:29 INFO - PROCESS | 13132 | |3;audio-fft;76;76;77;116;77;77;76;76;109;76 09:38:29 INFO - PROCESS | 13132 | |4;audio-oscillator;83;82;117;85;84;85;107;83;90;119 09:38:29 INFO - PROCESS | 13132 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;117;117;117 09:38:29 INFO - PROCESS | 13132 | |6;imaging-darkroom;148;148;148;147;148;147;146;147;147;147 09:38:29 INFO - PROCESS | 13132 | |7;imaging-desaturate;95;97;97;96;95;96;95;95;95;96 09:38:29 INFO - PROCESS | 13132 | |8;json-parse-financial;51;52;52;53;53;53;53;53;53;53 09:38:29 INFO - PROCESS | 13132 | |9;json-stringify-tinderbox;60;61;60;61;61;60;61;60;61;62 09:38:29 INFO - PROCESS | 13132 | |10;stanford-crypto-aes;80;81;87;82;83;87;81;82;81;81 09:38:29 INFO - PROCESS | 13132 | |11;stanford-crypto-ccm;150;133;133;132;142;130;138;132;168;141 09:38:29 INFO - PROCESS | 13132 | |12;stanford-crypto-pbkdf2;169;167;169;166;167;169;169;169;169;166 09:38:29 INFO - PROCESS | 13132 | |13;stanford-crypto-sha256-iterative;67;67;66;66;67;71;66;69;67;69 09:38:29 INFO - PROCESS | 13132 | __end_tp_report 09:38:29 INFO - PROCESS | 13132 | __start_cc_report 09:38:29 INFO - PROCESS | 13132 | _x_x_mozilla_cycle_collect,1643 09:38:29 INFO - PROCESS | 13132 | __end_cc_report 09:38:29 INFO - PROCESS | 13132 | __startTimestamp1475771909589__endTimestamp 09:38:29 INFO - PROCESS | 13132 | 09:38:29 INFO - PROCESS | 13132 | ------- Summary: start ------- 09:38:29 INFO - PROCESS | 13132 | Number of tests: 14 09:38:29 INFO - PROCESS | 13132 | 09:38:29 INFO - PROCESS | 13132 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 09:38:29 INFO - PROCESS | 13132 | Values: 112.0 111.0 111.0 112.0 111.0 111.0 110.0 112.0 111.0 111.0 09:38:29 INFO - PROCESS | 13132 | 09:38:29 INFO - PROCESS | 13132 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:128.00 stddev:16.67 (13.0%) stddev-sans-first:16.37 09:38:29 INFO - PROCESS | 13132 | Values: 153.0 128.0 124.0 166.0 125.0 123.0 122.0 128.0 157.0 125.0 09:38:29 INFO - PROCESS | 13132 | 09:38:29 INFO - PROCESS | 13132 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:1.43 (0.9%) stddev-sans-first:1.50 09:38:29 INFO - PROCESS | 13132 | Values: 162.0 161.0 165.0 161.0 163.0 162.0 162.0 165.0 162.0 163.0 09:38:29 INFO - PROCESS | 13132 | 09:38:29 INFO - PROCESS | 13132 | [#3] audio-fft Cycles:10 Average:83.60 Median:76.00 stddev:15.33 (20.2%) stddev-sans-first:16.01 09:38:29 INFO - PROCESS | 13132 | Values: 76.0 76.0 77.0 116.0 77.0 77.0 76.0 76.0 109.0 76.0 09:38:29 INFO - PROCESS | 13132 | 09:38:29 INFO - PROCESS | 13132 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:83.50 stddev:14.85 (17.8%) stddev-sans-first:15.26 09:38:29 INFO - PROCESS | 13132 | Values: 83.0 82.0 117.0 85.0 84.0 85.0 107.0 83.0 90.0 119.0 09:38:29 INFO - PROCESS | 13132 | 09:38:29 INFO - PROCESS | 13132 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:38:29 INFO - PROCESS | 13132 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 09:38:29 INFO - PROCESS | 13132 | 09:38:29 INFO - PROCESS | 13132 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 09:38:29 INFO - PROCESS | 13132 | Values: 148.0 148.0 148.0 147.0 148.0 147.0 146.0 147.0 147.0 147.0 09:38:29 INFO - PROCESS | 13132 | 09:38:29 INFO - PROCESS | 13132 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 09:38:29 INFO - PROCESS | 13132 | Values: 95.0 97.0 97.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 09:38:29 INFO - PROCESS | 13132 | 09:38:29 INFO - PROCESS | 13132 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:0.70 (1.3%) stddev-sans-first:0.44 09:38:29 INFO - PROCESS | 13132 | Values: 51.0 52.0 52.0 53.0 53.0 53.0 53.0 53.0 53.0 53.0 09:38:29 INFO - PROCESS | 13132 | 09:38:29 INFO - PROCESS | 13132 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 09:38:29 INFO - PROCESS | 13132 | Values: 60.0 61.0 60.0 61.0 61.0 60.0 61.0 60.0 61.0 62.0 09:38:29 INFO - PROCESS | 13132 | 09:38:29 INFO - PROCESS | 13132 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.00 stddev:2.51 (3.1%) stddev-sans-first:2.49 09:38:29 INFO - PROCESS | 13132 | Values: 80.0 81.0 87.0 82.0 83.0 87.0 81.0 82.0 81.0 81.0 09:38:29 INFO - PROCESS | 13132 | 09:38:29 INFO - PROCESS | 13132 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:139.50 stddev:11.64 (8.3%) stddev-sans-first:11.76 09:38:29 INFO - PROCESS | 13132 | Values: 150.0 133.0 133.0 132.0 142.0 130.0 138.0 132.0 168.0 141.0 09:38:29 INFO - PROCESS | 13132 | 09:38:29 INFO - PROCESS | 13132 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:169.00 stddev:1.33 (0.8%) stddev-sans-first:1.36 09:38:29 INFO - PROCESS | 13132 | Values: 169.0 167.0 169.0 166.0 167.0 169.0 169.0 169.0 169.0 166.0 09:38:29 INFO - PROCESS | 13132 | 09:38:29 INFO - PROCESS | 13132 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.00 stddev:1.65 (2.5%) stddev-sans-first:1.74 09:38:29 INFO - PROCESS | 13132 | Values: 67.0 67.0 66.0 66.0 67.0 71.0 66.0 69.0 67.0 69.0 09:38:29 INFO - PROCESS | 13132 | -------- Summary: end -------- 09:38:29 INFO - PROCESS | 13132 | 09:38:30 INFO - TEST-INFO | 13132: exit 0 09:38:30 INFO - TEST-OK | kraken | took 61725ms 09:38:30 INFO - SUITE-END | took 1178s 09:38:31 INFO - Completed test suite (00:19:38) 09:38:31 INFO - javascript benchmark 09:38:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3019.909402717918, 3052.4352994695982, 3059.204606802231, 3077.153782709753, 3103.255218747501, 5048.671836330636, 5169.0, 5264.710440925747, 5316.3620365556135, 5363.6245462817615, 5298.4436634153435, 5317.0, 5368.46315368463, 5374.247605335247, 5478.58910581706, 4828.73441960692, 4883.658143929926, 4883.780229889646, 4901.06879692859, 4953.380827396575, 4986.601071914238, 5023.698578085308, 5028.120078986181, 5029.094762942669, 5065.1642478990925, 4683.2975053741875, 4731.384919960383, 4733.621310295202, 4922.21244600864, 4936.01279744049, 4782.521747825224, 4785.64107691921, 4811.975940120277, 4815.975920120377, 4858.732769697665, 4773.4510531289, 4796.760161991921, 4806.49531799163, 4819.44576373718, 4864.878378040542, 5341.2255222992835, 5363.0, 5381.219723140122, 5386.757595908193, 5386.946130538723, 5502.422245664187, 5539.14143307788, 5555.138953462219, 5650.886982260373, 5734.913976290359, 5726.885462290731, 5747.4252574742195, 5779.913301300484, 5783.681897495636, 5830.562707796932, 5424.376196737387, 5427.810026649048, 5430.321209848769, 5430.5927055471, 5432.837014889559, 5600.299962504687, 5618.101103823368, 5908.527317814564, 5911.881762364728, 5912.881742365129, 5607.186957891165, 5638.548916086703, 5642.379338272869, 5718.285214348207, 5720.971395143081, 5737.770489180386, 5741.167530708024, 5759.308882934075, 5805.042168042226, 5807.82576522705, 5374.167004114369, 5779.971100144472, 5783.0, 5792.4497172768515, 5796.739146738407, 5437.510624043855, 5639.238702775155, 5643.661380317194, 5651.802186923438, 5688.175214593861, 4370.453693288339, 4381.539938306496, 4383.649308055348, 4390.62679672225, 4438.667099967515, 3917.059905622687, 3918.1380096378753, 3947.585503522089, 3980.0845805464905, 3996.6003399659803, 5206.479352064764, 5263.210518422191, 5418.972905135449, 5461.5357694596405, 5472.2338872557875, 5735.0, 5739.713014349266, 5742.54059675225, 5744.195812586241, 5801.88396232073, 5459.945400545944, 5475.425080366584, 5480.616356855062, 5482.342118945752, 5488.231647569343, 4779.426468823764, 4789.425268967677, 4831.444383895897, 4925.581325587365, 5027.874303142451, 5890.410958904075, 5939.940600594025, 5959.582829201914, 5979.880402391927, 5983.461488466059, 5760.798372056958, 5765.7117144141785, 5765.8558536036935, 5776.624519406225, 5784.045632470596, 5712.485876271156, 5954.940450595439, 5965.701714914324, 5967.134765458897, 5977.252843394575, 5430.647007944471, 5531.640443371168, 5606.159076138611, 5611.607187496836, 5693.259876216231, 5665.178549110274, 5707.6290041147195, 5711.685857277889, 5715.771369145187, 5724.942750572608, 5549.334079910436, 5556.138798486241, 5560.833175004756, 5564.55483561306, 5568.359638641446, 5346.759395827119, 5462.098753705753, 5530.087535556749, 5551.722413879371, 5589.748461319332, 5527.419620939904, 5576.386597474356, 5622.3815380307315, 5629.352624448077, 5638.041532939328, 5585.832425027255, 5589.720513974366, 5594.3286805581965, 5601.159826026129, 5608.747606357805, 5306.54894333986, 5316.415194328543, 5476.863078423071, 5494.340679118532, 5548.472895074961], "value": 5266.041289456329, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.113792932547, 591.7248479457049, 600.4055984575269, 608.2883026858575, 611.2420598457913, 31578.368432631363, 43072.784636076816, 43969.34045989313, 43975.78012109943, 43982.340264895975, 44591.554084459145, 45112.0977580449, 45161.0, 45181.0, 45219.77390113053, 8008.719694810683, 8203.58982050898, 8733.91266087339, 8943.686970956018, 8945.686900958468, 10445.529951152179, 10638.0, 10687.465626718633, 10862.782744345148, 10868.130549556055, 10654.360738355685, 10728.624498142566, 10730.356178629307, 10739.087177589876, 10740.409277489734, 8017.839643207161, 8216.876746848802, 10436.425996570186, 10515.631952881651, 10598.841017384706, 10106.039926206999, 10541.578336866516, 10547.84178237327, 10553.73615659607, 10560.26078174528, 41989.16021679549, 42431.7878410606, 42444.78777606123, 42461.363079553834, 42508.57491425108, 3415.3852306584804, 3432.1762776933606, 3455.3262113887804, 3478.3043391321835, 3513.578370595545, 31469.527957080663, 31478.842605787053, 31815.681843181734, 31999.680003200137, 32003.359932801213, 4309.913801723948, 4356.215881141393, 4564.885877853047, 4597.0, 4613.0, 290314.0, 290811.54594227107, 292497.0, 294096.0, 295368.0, 35729.46405803915, 57752.71123644355, 58387.99999999915, 58895.41104588985, 58919.41080589225, 37325.62674373222, 37362.62637373646, 37504.24991500155, 37628.24743505169, 37645.62354376476, 13706.38321275545, 13982.51061212873, 13993.65015874591, 14002.85997140036, 14004.719905602034, 9919.156871665846, 10117.595296188218, 10134.746631334276, 10507.264491485676, 11313.886861131448, 8374.49753014821, 8646.956765216133, 8651.134886511298, 8689.6524139035, 8781.91218087811, 3343.749218808599, 3346.3140056288403, 3421.4867769834723, 3435.089701229176, 3467.0465621954163, 975.7658162041059, 977.8777652793401, 980.122790102854, 981.7790997025755, 1078.7464945737745, 30067.248318792204, 31250.84374578158, 31386.0, 31412.528812067838, 31619.992201481644, 1027.527337424793, 1055.646358469921, 1068.0921216965517, 1120.0647459371517, 1149.9305645749366, 15047.0, 16409.67180656404, 16485.0, 16744.24650890713, 16758.24587893548, 481774.0, 492615.0, 493653.317334139, 493905.0, 495216.0, 55418.722906386014, 55935.44064559302, 55951.0, 55986.0, 56063.439365605824, 1200.5137919142587, 1239.8822111899356, 1294.152330223705, 1307.6926922173282, 1340.7787715026911, 27278.0, 30744.846275769374, 31396.215094622818, 31869.20326991844, 32354.676453235166, 47943.28085078657, 48161.75919120522, 48601.513984861114, 48637.27044094271, 48673.0, 360634.0, 360824.0, 362068.0, 362816.0, 362939.0, 27247.45505089927, 28465.715342846306, 28536.0, 29561.704382955893, 29608.0, 45384.77307613441, 46251.53748462607, 46545.76727116343, 46653.76673116613, 47127.0, 38816.41775373315, 39197.0, 39473.40789888211, 39496.210075798896, 41009.38485922654, 37391.25217495689, 37669.0, 37735.81132094322, 38011.809940950116, 38526.42210366903, 38483.230335393695, 39012.0, 39632.801835990635, 39851.60148398479, 39873.60126398699, 32039.359212815147, 34453.0, 34574.82712586421, 35634.0, 36370.0, 26074.348141296618, 27397.58903616487, 27434.725652744015, 27598.862005689843, 27893.44213115767], "value": 18530.373734992816, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.6765330335956, 398.3765407137829, 399.8440608162816, 402.2879503279196, 427.6835141994925, 13374.264415457146, 15356.385744570218, 18994.525136871584, 19377.128029238684, 19632.999999999964, 18953.810461895377, 19088.71366929497, 19312.903435482804, 19534.60930781387, 19585.412437626896, 5573.191887176357, 5828.941710582903, 5883.411658834125, 5884.440978107073, 5891.851089037639, 5987.730552125143, 6144.6006009609455, 6148.938510614904, 6149.29283132441, 6155.230596175478, 3997.580254073324, 4190.832366705328, 5826.621269617462, 6019.277686677605, 6025.879482410349, 5864.76540938362, 6025.397460253984, 6078.361772013941, 6088.117223002662, 6101.054336577838, 5862.677552734598, 5906.3798301178185, 5910.231669882931, 5913.970430147821, 5914.497267732248, 14353.138811671333, 18530.62938741231, 22595.661065084038, 23187.53624927509, 23352.883235583882, 2269.262489690857, 2296.4603318220206, 2396.1493669747338, 2432.221689059502, 2532.3669082729316, 10170.0, 10256.384616922935, 10260.589576416935, 10810.513526891309, 10820.621278255223, 1767.142935676196, 1861.3857427049177, 1885.7831349394858, 1893.0818553001784, 1914.0716752375088, 81987.88193889009, 83248.58375708143, 83631.581842091, 84308.99999999939, 86888.0, 10557.9472102639, 10779.407132607781, 11031.393273369882, 11094.22340436178, 11149.498272577754, 15638.0, 15761.29074191664, 15771.132587707787, 15798.763018554731, 15820.76268855968, 7479.364254038359, 7742.0064058682965, 7842.843143137219, 7947.841043179104, 8015.719449819228, 7388.778336649909, 7441.85116297671, 7443.776686699408, 7645.4648174628355, 7721.382289416833, 4714.45783734868, 4742.288656701453, 4755.38180036593, 4865.537773911473, 4960.454350021495, 1925.9903700481689, 1954.4136758972252, 2010.7687615924062, 2017.5258814178655, 2020.40398082566, 853.2150421612132, 904.3036861616519, 904.9142424332993, 916.4501299220415, 989.2135752077116, 17056.147192640317, 18169.909150454165, 18760.343387981356, 18929.24283028691, 18978.335758248395, 979.5787811241092, 983.1495756171004, 993.6869885985891, 1011.1304278320786, 1041.578160844859, 9342.813143737087, 10178.643747468803, 10479.266451348332, 10522.631707890187, 10593.735156621146, 410647.0, 412899.0, 418995.0, 428632.0, 428731.0, 66211.0, 76761.0, 76845.0, 79802.60098699469, 88150.11849881547, 950.0594411532533, 966.0677446264389, 986.6891929042329, 987.7234374375187, 991.0832479956011, 16352.100634465218, 16776.0, 16964.0, 17247.56881077933, 17289.740653890454, 37501.62485376329, 39707.40438893361, 39979.2004159921, 40225.59774402218, 41528.1694366117, 48819.75590122027, 50885.0, 51906.22140667969, 52481.21278180907, 54208.45791542034, 7394.186639469546, 7800.492967957065, 8128.3497320213055, 8342.457740246864, 8451.535165565952, 8107.878381824396, 10147.036031576989, 12332.383380831103, 13184.802227966396, 13243.470261189444, 7949.3243074337015, 10116.848247276444, 11667.59163429276, 11803.114766392726, 11816.940915295369, 11236.213465057368, 11353.318800871974, 11362.659120226406, 11462.312261264351, 11545.653630391102, 11384.203105782515, 11576.146002571377, 11644.2431241969, 12088.15382923187, 12219.69450763738, 7724.536527808349, 7793.337566306927, 7872.488288261474, 8129.512229266263, 8162.42862999608, 10083.848742269018, 11356.488957996744, 11369.715757106138, 11751.941240294085, 11932.701682458008], "value": 8903.451210827834, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1475.2623688155923, 1502.9473968411107, 1644.8684105271573, 1783.2064731194623, 1811.1125548481248, 8052.4765890217095, 8381.371397145223, 8739.388242822997, 9423.905760942396, 9428.71713848584, 8766.211041006309, 9079.727608171748, 9095.954520227406, 9214.170724634781, 9235.722928312161, 2361.929142125735, 2390.521895620874, 2392.222527678503, 2395.808335333178, 2396.808255339569, 1939.76722793265, 2005.7392538969914, 2262.875541845198, 2285.1544928376525, 2332.918347857825, 2358.716953965518, 2400.711914570254, 2400.939976500584, 2411.505641343529, 2413.1795189635523, 2341.7072865891764, 2342.227065068523, 2352.329586067971, 2386.1648423051965, 2391.5336509380677, 2292.5529521743265, 2340.9648855267183, 2348.0607756897207, 2348.5537747827857, 2363.7163540375095, 9147.771305717344, 9147.817043659155, 9203.53982300889, 9226.354155209137, 9241.075892410705, 5361.490658387447, 5481.862953426156, 5527.143292789624, 5537.723113844291, 5543.805966791183, 3479.4780782882517, 3547.130952916552, 3625.5105560749225, 3626.5104210931713, 3658.487811706363, 1127.4419162514525, 1137.8805225451374, 1157.7395086105644, 1187.424099311833, 1199.3643369014437, 13152.934235328858, 13153.473861045546, 13176.275304858229, 13195.670108247275, 13225.470981160743, 4546.931796023062, 4704.9529504704515, 4796.448408433005, 4864.464908860094, 4891.241857512091, 10969.890301097046, 10978.066864316463, 11005.229633925548, 11007.944960275308, 11013.83479247796, 5444.754986025639, 5451.373092094381, 5456.263404440429, 5460.972695136499, 5465.535429488458, 4762.3808904842845, 4848.0, 5017.67385119966, 5019.67372120811, 5024.748762561857, 3633.927321453556, 3647.854085836537, 3689.3912504437003, 3701.759385639925, 3752.3058234226755, 1028.8662473878348, 1030.217035053365, 1068.8022715797601, 1089.8201796703613, 1104.4036220441033, 821.199330652609, 926.4117285523741, 929.9116583924516, 945.8061097475002, 950.5152372290182, 5934.910976335358, 5975.2373049950365, 6024.969875150684, 6152.3540028297275, 6196.81409557714, 952.3333666433524, 963.21016766251, 966.6471737815647, 973.9026097390205, 999.0, 3997.420374045805, 4084.4485994390375, 4088.2232375848494, 4114.7942602870335, 4208.494980602286, 11307.0, 11519.136064795173, 11602.419879006016, 11657.125715571197, 11663.941680291713, 10772.0, 11312.0, 11500.482478288497, 11520.078393728481, 11561.942190288995, 8370.916290837136, 8575.099614540508, 8579.099194584604, 8586.184312490428, 8592.613332400057, 5929.644221346733, 6005.279366476051, 6066.636001839727, 6317.872628187293, 6325.399087086904, 10098.0, 10516.68449946503, 10669.306495077795, 10705.89294107049, 10711.732206694895, 10403.947980260353, 10647.680569582924, 10856.077233435246, 10965.342079474938, 10986.340819550853, 7930.722424715107, 8027.638756256099, 8038.758837234892, 8043.034835819739, 8047.0745864226365, 8813.515256660688, 8879.422837515542, 8882.333824963283, 8895.688650897446, 8897.110288971051, 7617.771466856003, 7955.602219888867, 8057.677692892219, 8110.837783244184, 8170.060443049126, 7831.84336313282, 7860.135385107748, 7878.172791856772, 8007.079185893696, 8089.110197878346, 6721.529492935643, 6789.388954994074, 6793.218779840184, 6905.240423553305, 7070.04554385172, 4998.875028124326, 5073.695578265316, 5157.355330583677, 5243.449437808975, 5320.255164276927, 5163.122269214317, 5239.109351410346, 5274.375062244766, 5306.787728490817, 5322.707251101072], "value": 4731.109938744199, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.1337269608235, 330.91892486340845, 337.40111302438174, 339.7774457730186, 343.24999875272545, 5358.732063396829, 5420.9186862197, 5432.429594892538, 5453.318335208099, 5462.170172992048, 5094.261332106842, 5217.921731174036, 5229.267902493654, 5342.252084708134, 5380.892382152364, 4224.408582798411, 4229.725067870579, 4254.446921900164, 4258.913976935893, 4275.294576394891, 4236.57634236577, 4245.426867372911, 4246.27813271743, 4249.44757181566, 4251.744895306291, 4061.6547593454593, 4164.354525048622, 4170.70805043647, 4177.248095342837, 4182.665386769051, 4142.958570414317, 4164.292070348018, 4164.312888373414, 4174.457320548325, 4195.4336164618, 3669.6513831185994, 3677.7793332400142, 3680.208755117636, 3687.1519550503267, 3688.5942546319884, 5014.0, 5217.713025783581, 5220.3735551734035, 5228.189630607262, 5232.241325007891, 4751.384529260068, 4769.689970151929, 4769.856904292877, 4772.637544415502, 4776.307435421879, 5612.887742245132, 5625.38120806711, 5628.240187574707, 5642.717864106819, 5652.576056795716, 3923.7836270756156, 3996.360582306817, 4023.155137421145, 4046.433499310099, 4052.4124002019544, 5816.88366232673, 5852.4440178183, 5855.355910849803, 5889.499392551638, 5890.705464726747, 4078.327076032481, 4080.591940805896, 4080.9795951020646, 4092.1201941582704, 4095.119549296856, 3955.8417663293144, 4109.3425051991535, 4114.786138089271, 4131.215069136854, 4137.3243836246365, 4713.6464765142755, 4738.19450693383, 4739.786709598076, 4747.715137091716, 4758.0, 5668.659880407189, 5671.234383358276, 5677.517411020027, 5677.801276955287, 5686.2323586315315, 1392.8328600567997, 1426.686129051607, 1438.978415323771, 1445.551878917539, 1449.948787129323, 898.0749827677503, 910.526526206369, 922.1239822168966, 922.2667978956746, 922.7831459606987, 4874.830700338386, 4891.902161956741, 4901.607871370282, 4910.477751896923, 4915.901681966412, 5119.385673719103, 5137.691738495628, 5162.225666150108, 5166.741662916839, 5170.767315470813, 4441.489893436247, 4783.832565860178, 4795.434442573207, 4801.279808028824, 4817.855464336076, 2678.5758888206205, 2679.2632026192955, 2692.3942113024805, 2695.2588038289628, 2702.8108032437935, 5134.486551344836, 5160.277561141444, 5188.533032027136, 5198.972400763705, 5219.19102539107, 4746.359241502422, 5101.591872650179, 5105.412877519058, 5123.462036486189, 5151.871203219949, 5153.788859618062, 5163.463027825951, 5170.1986192140275, 5190.558802501754, 5203.245529398292, 4951.762059485129, 4981.775820088177, 5027.019731152536, 5063.544281014726, 5077.543021128116, 4790.520947905321, 5011.070737766059, 5028.371453568304, 5041.0, 5069.437506244262, 5268.341457317835, 5283.203710738214, 5283.524482796567, 5295.76169072385, 5302.825841405005, 3754.4231422803036, 3759.8308076137187, 3765.378712512405, 3782.432635104756, 3862.4978752761963, 5593.916091258553, 5619.634723742944, 5766.192733017297, 5769.59612827098, 5779.913301300568, 5522.502974732132, 5569.415211402907, 5576.944230557642, 5582.469665381782, 5593.692346920959, 5340.49265319794, 5568.470995255444, 5577.609567330248, 5588.981949747254, 5620.718964051863, 5604.887902242014, 5612.8877422450505, 5613.270274864241, 5613.522850557748, 5620.325560932551, 5603.487058494102, 5611.2424822650055, 5611.438856114356, 5631.577631677723, 5645.125005624135, 5265.657732247391, 5505.862353441035, 5534.944650553604, 5538.695371754592, 5542.944570554243], "value": 4122.993190307142, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.2787212787213, 739.142594590275, 776.8951191589134, 798.9280964713176, 840.5965136734371, 15365.078095314275, 16031.0, 16069.0, 16148.515544533682, 16207.270672819723, 15470.61323466914, 15546.76679849803, 15548.222588870567, 15600.843991560081, 15674.451394201205, 652.3378770547874, 686.2862622872207, 802.542550746075, 823.8558252305822, 827.8137419080689, 772.1737740617541, 804.9396295277849, 805.1465446626565, 809.7773112394079, 814.975550733476, 848.2620120495147, 853.3471894001094, 854.2055888024136, 855.102142750113, 858.9828203435927, 676.4723515657795, 848.2238751542332, 849.8852654891604, 857.5883575883548, 857.8284343131368, 515.4973900447071, 597.0298265318856, 617.9443850053517, 619.2043224456596, 620.6710443464971, 14556.417743290256, 14574.417023319054, 14577.562673119823, 14590.489332873298, 14596.416143354252, 13461.528846490326, 13969.092009019381, 14233.928830355782, 14393.35229914646, 14469.0, 12890.80663790044, 13124.648864184384, 13265.734685306335, 13344.799828002491, 13510.932445337809, 4404.779761011969, 4412.448443944507, 4417.491988421309, 4515.322701594754, 4580.541945805426, 77170.6141469289, 79184.81222781721, 79256.0, 79318.6034069826, 80466.19533804645, 11299.943500282447, 11336.546538138547, 11465.656030319104, 11499.827502587468, 11660.70848228784, 18964.14661340243, 19845.4046378606, 19991.300304489272, 20553.58892822135, 20655.896720516303, 8102.473339233049, 8195.262426381654, 8217.424780265324, 8327.167283271625, 8554.144585541397, 4699.929501057487, 4775.737334446639, 4787.305840653085, 4791.329213910055, 4854.538818812207, 3571.946420803638, 3705.5182826232417, 3711.628837116267, 3712.7215458840697, 3722.1389305347325, 651.1177354684429, 651.6969609131777, 655.1221363373103, 667.1693741292122, 667.6861874918781, 666.4980585268577, 676.5872817581271, 711.4379640084379, 743.6690672650618, 757.1973707869676, 9594.1365277124, 9630.2777291702, 10047.555298019837, 10268.794624107626, 10291.948540257401, 567.7927556441952, 591.5829340315067, 721.8917162425678, 724.4530379563502, 728.4172661870482, 4487.4839393470165, 4699.130660827758, 4709.929351059737, 4720.811167553328, 4751.453582838018, 68783.31216687869, 70055.29944700589, 76054.61972690212, 123910.0, 127338.0, 80877.59561202273, 82453.58773206096, 106277.46861265645, 108805.20753132098, 110616.4469177665, 52483.73758131185, 63895.68052159803, 75178.0, 75995.24004759992, 82308.0, 9337.953310233406, 9882.160016398686, 9884.505774711091, 9977.750556235862, 10112.59549618007, 47453.0, 48234.758826205645, 48694.26958595553, 49766.751166243936, 50242.49757502378, 65540.0, 66474.0, 72642.63678681572, 73442.63278683572, 74387.0, 12417.813732793835, 12572.245665260114, 12921.418536166084, 13179.472821087049, 13522.86477135216, 14314.0, 14498.275086245856, 14675.92662036683, 15292.31184596718, 15474.14892180896, 10587.682369528926, 13263.80104298417, 13634.250116243702, 13697.383617737027, 15064.623384415478, 13740.312984350943, 14039.859601403856, 14109.647258818612, 14129.222892740998, 14608.196549189897, 12936.611901642966, 13459.259740714355, 13532.188068715908, 13784.172949623055, 14063.929680351943, 10804.837927430937, 10975.50610222526, 11533.423328833693, 11623.070154387799, 11969.700757481132, 10991.450427478434, 11285.887141128484, 11797.941010294893, 11813.822792657946, 11960.0], "value": 7500.080801786737, "unit": "score"}], "name": "dromaeo_css", "value": 7090.906767262013, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 111.0, 112.0, 111.0, 111.0, 110.0, 112.0, 111.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 124.0, 166.0, 125.0, 123.0, 122.0, 128.0, 157.0, 125.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 165.0, 161.0, 163.0, 162.0, 162.0, 165.0, 162.0, 163.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 116.0, 77.0, 77.0, 76.0, 76.0, 109.0, 76.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 117.0, 85.0, 84.0, 85.0, 107.0, 83.0, 90.0, 119.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 97.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 52.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 61.0, 60.0, 61.0, 60.0, 61.0, 62.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 87.0, 82.0, 83.0, 87.0, 81.0, 82.0, 81.0, 81.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 133.0, 133.0, 132.0, 142.0, 130.0, 138.0, 132.0, 168.0, 141.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 169.0, 166.0, 167.0, 169.0, 169.0, 169.0, 169.0, 166.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 67.0, 71.0, 66.0, 69.0, 67.0, 69.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1517.4, "alertThreshold": 2.0}]} 09:38:31 INFO - Return code: 0 09:38:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:38:31 INFO - # TBPL SUCCESS # 09:38:31 INFO - Running post-action listener: _resource_record_post_action 09:38:31 INFO - [mozharness: 2016-10-06 16:38:31.393411Z] Finished run-tests step (success) 09:38:31 INFO - Running post-run listener: _resource_record_post_run 09:38:31 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393609216; Read time: 12; Write time: 259348 09:38:31 INFO - TinderboxPrint: CPU usage
13.1% 09:38:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:38:31 INFO - TinderboxPrint: I/O write bytes / time
393,609,216 / 259,348 09:38:31 INFO - TinderboxPrint: CPU idle
8,290.0 (86.9%) 09:38:31 INFO - TinderboxPrint: CPU user
1,199.5 (12.6%) 09:38:31 INFO - TinderboxPrint: Swap in / out
0 / 0 09:38:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103837696; Read time: 0; Write time: 87952 09:38:31 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289771520; Read time: 0; Write time: 171396 09:38:32 INFO - Running post-run listener: _upload_blobber_files 09:38:32 INFO - Blob upload gear active. 09:38:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:38:32 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 09:38:32 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:38:32 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:38:32 INFO - (blobuploader) - INFO - Open directory for files ... 09:38:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:38:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:38:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:35 INFO - (blobuploader) - INFO - Done attempting. 09:38:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:38:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:38:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:36 INFO - (blobuploader) - INFO - Done attempting. 09:38:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:38:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:38:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:37 INFO - (blobuploader) - INFO - Done attempting. 09:38:37 INFO - (blobuploader) - INFO - Iteration through files over. 09:38:37 INFO - Return code: 0 09:38:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:38:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:38:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86b9565819b7690e8c46abde6ae12e29b679b0d6ac6be2c27d69a47c34ca3c2386e07c63f36306a15a3656315a5d0ccc9cd10cb35ef611ff98113571c9874713", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07613fe17c44d8cfc188a77aceccdc6b643ebf251ce0a2bd90533c67aca6551ca1bea7a7234d87c355e7e5fdadf62e6cd340a89cab4e18848827c008c42b3235", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17da31927333116197a4a2b4b764860191e6889d52f9e4f8d681cd84c818852dcde71bc4b01b2e589730013a5abad4ec5d05cc774df7fd531ca4be26203d32c7"} 09:38:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:38:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:38:37 INFO - Contents: 09:38:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86b9565819b7690e8c46abde6ae12e29b679b0d6ac6be2c27d69a47c34ca3c2386e07c63f36306a15a3656315a5d0ccc9cd10cb35ef611ff98113571c9874713", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07613fe17c44d8cfc188a77aceccdc6b643ebf251ce0a2bd90533c67aca6551ca1bea7a7234d87c355e7e5fdadf62e6cd340a89cab4e18848827c008c42b3235", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17da31927333116197a4a2b4b764860191e6889d52f9e4f8d681cd84c818852dcde71bc4b01b2e589730013a5abad4ec5d05cc774df7fd531ca4be26203d32c7"} 09:38:37 INFO - Running post-run listener: copy_logs_to_upload_dir 09:38:37 INFO - Copying logs to upload dir... 09:38:37 INFO - mkdir: /builds/slave/test/build/upload/logs 09:38:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.094251 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-06 09:38:37.184549) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 09:38:37.188099) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86b9565819b7690e8c46abde6ae12e29b679b0d6ac6be2c27d69a47c34ca3c2386e07c63f36306a15a3656315a5d0ccc9cd10cb35ef611ff98113571c9874713", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07613fe17c44d8cfc188a77aceccdc6b643ebf251ce0a2bd90533c67aca6551ca1bea7a7234d87c355e7e5fdadf62e6cd340a89cab4e18848827c008c42b3235", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17da31927333116197a4a2b4b764860191e6889d52f9e4f8d681cd84c818852dcde71bc4b01b2e589730013a5abad4ec5d05cc774df7fd531ca4be26203d32c7"} build_url:https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011471 build_url: 'https://queue.taskcluster.net/v1/task/HNuzaVgZTXygIGBEIrQmkQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86b9565819b7690e8c46abde6ae12e29b679b0d6ac6be2c27d69a47c34ca3c2386e07c63f36306a15a3656315a5d0ccc9cd10cb35ef611ff98113571c9874713", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07613fe17c44d8cfc188a77aceccdc6b643ebf251ce0a2bd90533c67aca6551ca1bea7a7234d87c355e7e5fdadf62e6cd340a89cab4e18848827c008c42b3235", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17da31927333116197a4a2b4b764860191e6889d52f9e4f8d681cd84c818852dcde71bc4b01b2e589730013a5abad4ec5d05cc774df7fd531ca4be26203d32c7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 09:38:37.213112) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 09:38:37.213392) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1475770676.818033-1927866777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 09:38:37.297707) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 09:38:37.298186) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 09:38:37.298623) ========= ========= Total master_lag: 0.17 =========