builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1475740056.57 results: success (0) buildid: 20161005213024 builduid: e48f7db544ed4909a0cec531038332a3 revision: ad3b71ecafeb0b0366750eb3a771224e05a194ee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 00:47:36.567281) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 00:47:36.567798) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 00:47:36.568125) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 00:47:36.583299) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 00:47:36.583593) ========= 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=836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 00:47:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-10-06 00:47:37 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124707 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 00:47:36.721833) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 00:47:36.722143) ========= 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=836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015793 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 00:47:36.771529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 00:47:36.771885) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ad3b71ecafeb0b0366750eb3a771224e05a194ee --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 ad3b71ecafeb0b0366750eb3a771224e05a194ee --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=836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 00:47:37,832 truncating revision to first 12 chars 2016-10-06 00:47:37,832 Setting DEBUG logging. 2016-10-06 00:47:37,832 attempt 1/10 2016-10-06 00:47:37,832 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ad3b71ecafeb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 00:47:38,135 unpacking tar archive at: fx-team-ad3b71ecafeb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.719946 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 00:47:37.509963) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 00:47:37.510264) ========= script_repo_revision: ad3b71ecafeb0b0366750eb3a771224e05a194ee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 00:47:37.510659) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 00:47:37.510954) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 00:47:37.520721) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-06 00:47:37.521015) ========= /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=836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:47:38 INFO - MultiFileLogger online at 20161006 00:47:38 in /builds/slave/test 00:47:38 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 00:47:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:47:38 INFO - {'append_to_log': False, 00:47:38 INFO - 'base_work_dir': '/builds/slave/test', 00:47:38 INFO - 'blob_upload_branch': 'Fx-Team', 00:47:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:47:38 INFO - 'branch': 'Fx-Team', 00:47:38 INFO - 'buildbot_json_path': 'buildprops.json', 00:47:38 INFO - 'config_files': ('talos/linux_config.py',), 00:47:38 INFO - 'default_actions': ('clobber', 00:47:38 INFO - 'read-buildbot-config', 00:47:38 INFO - 'download-and-extract', 00:47:38 INFO - 'populate-webroot', 00:47:38 INFO - 'create-virtualenv', 00:47:38 INFO - 'install', 00:47:38 INFO - 'run-tests'), 00:47:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:47:38 INFO - 'download_minidump_stackwalk': True, 00:47:38 INFO - 'download_symbols': 'ondemand', 00:47:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:47:38 INFO - 'tooltool.py': '/tools/tooltool.py', 00:47:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:47:38 INFO - '/tools/misc-python/virtualenv.py')}, 00:47:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:47:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:47:38 INFO - 'installer_path': 'installer.exe', 00:47:38 INFO - 'log_level': 'info', 00:47:38 INFO - 'log_name': 'talos', 00:47:38 INFO - 'log_to_console': True, 00:47:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:47:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:47:38 INFO - 'opt_config_files': (), 00:47:38 INFO - 'pip_index': False, 00:47:38 INFO - 'sps_profile': False, 00:47:38 INFO - 'sps_profile_interval': 0, 00:47:38 INFO - 'suite': 'dromaeojs', 00:47:38 INFO - 'system_bits': '32', 00:47:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:47:38 INFO - 'title': 'talos-linux64-ix-028', 00:47:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:47:38 INFO - 'use_talos_json': True, 00:47:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:47:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:47:38 INFO - 'work_dir': 'build'} 00:47:38 INFO - [mozharness: 2016-10-06 07:47:38.678482Z] Running clobber step. 00:47:38 INFO - Running pre-action listener: _resource_record_pre_action 00:47:38 INFO - Running main action method: clobber 00:47:38 INFO - rmtree: /builds/slave/test/build 00:47:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:47:39 INFO - Running post-action listener: _resource_record_post_action 00:47:39 INFO - [mozharness: 2016-10-06 07:47:39.169693Z] Finished clobber step (success) 00:47:39 INFO - [mozharness: 2016-10-06 07:47:39.169805Z] Running read-buildbot-config step. 00:47:39 INFO - Running pre-action listener: _resource_record_pre_action 00:47:39 INFO - Running main action method: read_buildbot_config 00:47:39 INFO - Using buildbot properties: 00:47:39 INFO - { 00:47:39 INFO - "project": "", 00:47:39 INFO - "product": "firefox", 00:47:39 INFO - "script_repo_revision": "production", 00:47:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:47:39 INFO - "repository": "", 00:47:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 00:47:39 INFO - "buildid": "20161005213024", 00:47:39 INFO - "pgo_build": "True", 00:47:39 INFO - "basedir": "/builds/slave/test", 00:47:39 INFO - "buildnumber": 1109, 00:47:39 INFO - "slavename": "talos-linux64-ix-028", 00:47:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:47:39 INFO - "platform": "ubuntu64_hw", 00:47:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 00:47:39 INFO - "branch": "fx-team", 00:47:39 INFO - "repo_path": "integration/fx-team", 00:47:39 INFO - "revision": "ad3b71ecafeb0b0366750eb3a771224e05a194ee", 00:47:39 INFO - "stage_platform": "linux64-pgo", 00:47:39 INFO - "builduid": "e48f7db544ed4909a0cec531038332a3", 00:47:39 INFO - "slavebuilddir": "test" 00:47:39 INFO - } 00:47:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 00:47:39 INFO - Running post-action listener: _resource_record_post_action 00:47:39 INFO - [mozharness: 2016-10-06 07:47:39.172589Z] Finished read-buildbot-config step (success) 00:47:39 INFO - [mozharness: 2016-10-06 07:47:39.172687Z] Running download-and-extract step. 00:47:39 INFO - Running pre-action listener: _resource_record_pre_action 00:47:39 INFO - Running main action method: download_and_extract 00:47:39 INFO - mkdir: /builds/slave/test/build/tests 00:47:39 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')]} 00:47:39 INFO - trying https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:47:39 INFO - Downloading https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/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 00:47:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/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 00:47:39 INFO - Downloaded 1361 bytes. 00:47:39 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:47:39 INFO - Using the following test package requirements: 00:47:39 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:47:39 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:47:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:47:39 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:47:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:47:39 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:47:39 INFO - u'jsshell-linux-x86_64.zip'], 00:47:39 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:47:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:47:39 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:47:39 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:47:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:47:39 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:47:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:47:39 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:47:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:47:39 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:47:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:47:39 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:47:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:47:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:47:39 INFO - Fetch https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:47:40 INFO - Http code: 200 00:47:40 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 00:47:40 INFO - x-amz-cf-id: dz8O-EbWPiZ2SWojXD81vN4izMjt6pWZgO3_--RB0CKinlTfjU1ejg== 00:47:40 INFO - x-amz-version-id: aVilJXjUfoTfy28V4wN3TrHhfuvL542w 00:47:40 INFO - Expected file size: 21993156 00:47:40 INFO - Obtained file size: 21993156 00:47:44 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 00:47:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:47:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:47:44 INFO - Fetch https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:47:45 INFO - Http code: 200 00:47:45 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 00:47:45 INFO - x-amz-cf-id: autLxKc4-TOc8utZeHA6O-8rnbPmxjJoTlM510GRpgYaydG7gNB_9w== 00:47:45 INFO - x-amz-version-id: aVilJXjUfoTfy28V4wN3TrHhfuvL542w 00:47:45 INFO - Expected file size: 21993156 00:47:45 INFO - Obtained file size: 21993156 00:47:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 00:47:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:47:49 INFO - Fetch https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:47:50 INFO - Http code: 200 00:47:50 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 00:47:50 INFO - x-amz-cf-id: 4WvDfIbJkPnPzdQdstatELxQVIavlwTOillpUJOh81ijJCosybkePQ== 00:47:50 INFO - x-amz-version-id: 7tvf6clY9Dle7P292NRasbuMqWHL1iIw 00:47:50 INFO - Expected file size: 14409006 00:47:50 INFO - Obtained file size: 14409006 00:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:50 INFO - trying https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:47:50 INFO - Downloading https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/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 00:47:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/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 00:47:52 INFO - Downloaded 59708394 bytes. 00:47:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:47:52 INFO - mkdir: /builds/slave/test/properties 00:47:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:47:52 INFO - Writing to file /builds/slave/test/properties/build_url 00:47:52 INFO - Contents: 00:47:52 INFO - build_url:https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:47:52 INFO - Running post-action listener: _resource_record_post_action 00:47:52 INFO - Running post-action listener: set_extra_try_arguments 00:47:52 INFO - [mozharness: 2016-10-06 07:47:52.784880Z] Finished download-and-extract step (success) 00:47:52 INFO - [mozharness: 2016-10-06 07:47:52.785107Z] Running populate-webroot step. 00:47:52 INFO - Running pre-action listener: _resource_record_pre_action 00:47:52 INFO - Running main action method: populate_webroot 00:47:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:47:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:47:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:47:52 INFO - '--tppagecycles', 00:47:52 INFO - '7'], 00:47:52 INFO - 'tests': ['tsvgm']}}, 00:47:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:47:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:47:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:47:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:47:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:47:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:47:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:47:52 INFO - 'talos_options': ['--disable-e10s'], 00:47:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:47:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:47:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:47:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:47:52 INFO - 'talos_options': ['--disable-e10s'], 00:47:52 INFO - 'tests': ['damp', 'tps']}, 00:47:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:47:52 INFO - 'tests': ['damp', 'tps']}, 00:47:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:47:52 INFO - 'tests': ['dromaeo_dom']}, 00:47:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:47:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:47:52 INFO - 'tests': ['basic_compositor_video']}, 00:47:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:47:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:47:52 INFO - 'tests': ['a11yr', 00:47:52 INFO - 'ts_paint', 00:47:52 INFO - 'tpaint', 00:47:52 INFO - 'sessionrestore', 00:47:52 INFO - 'sessionrestore_no_auto_restore', 00:47:52 INFO - 'tabpaint']}, 00:47:52 INFO - 'other-e10s': {'tests': ['a11yr', 00:47:52 INFO - 'ts_paint', 00:47:52 INFO - 'tpaint', 00:47:52 INFO - 'sessionrestore', 00:47:52 INFO - 'sessionrestore_no_auto_restore', 00:47:52 INFO - 'tabpaint']}, 00:47:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:47:52 INFO - 'ts_paint', 00:47:52 INFO - 'tpaint', 00:47:52 INFO - 'sessionrestore', 00:47:52 INFO - 'sessionrestore_no_auto_restore', 00:47:52 INFO - 'tabpaint']}, 00:47:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:47:52 INFO - 'ts_paint', 00:47:52 INFO - 'tpaint', 00:47:52 INFO - 'sessionrestore', 00:47:52 INFO - 'sessionrestore_no_auto_restore', 00:47:52 INFO - 'tabpaint']}, 00:47:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:47:52 INFO - 'tests': ['a11yr', 00:47:52 INFO - 'ts_paint', 00:47:52 INFO - 'tpaint', 00:47:52 INFO - 'sessionrestore', 00:47:52 INFO - 'sessionrestore_no_auto_restore', 00:47:52 INFO - 'tabpaint']}, 00:47:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:47:52 INFO - 'tests': ['a11yr', 00:47:52 INFO - 'ts_paint', 00:47:52 INFO - 'tpaint', 00:47:52 INFO - 'sessionrestore', 00:47:52 INFO - 'sessionrestore_no_auto_restore', 00:47:52 INFO - 'tabpaint']}, 00:47:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:47:52 INFO - 'tests': ['tsvgx', 00:47:52 INFO - 'tsvgr_opacity', 00:47:52 INFO - 'tart', 00:47:52 INFO - 'tscrollx', 00:47:52 INFO - 'cart']}, 00:47:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:47:52 INFO - 'tsvgr_opacity', 00:47:52 INFO - 'tart', 00:47:52 INFO - 'tscrollx', 00:47:52 INFO - 'cart']}, 00:47:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:47:52 INFO - 'talos_options': ['--disable-e10s'], 00:47:52 INFO - 'tests': ['tp5o']}, 00:47:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:47:52 INFO - 'tests': ['tp5o']}, 00:47:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:47:52 INFO - 'talos_options': ['--disable-e10s', 00:47:52 INFO - '--xperf_path', 00:47:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:47:52 INFO - 'tests': ['tp5n']}, 00:47:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:47:52 INFO - 'talos_options': ['--xperf_path', 00:47:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:47:52 INFO - 'tests': ['tp5n']}}, 00:47:52 INFO - 'talos.zip': {'path': '', 00:47:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:47:52 INFO - Running post-action listener: _resource_record_post_action 00:47:52 INFO - [mozharness: 2016-10-06 07:47:52.807471Z] Finished populate-webroot step (success) 00:47:52 INFO - [mozharness: 2016-10-06 07:47:52.807560Z] Running create-virtualenv step. 00:47:52 INFO - Running pre-action listener: _resource_record_pre_action 00:47:52 INFO - Running main action method: create_virtualenv 00:47:52 INFO - Creating virtualenv /builds/slave/test/build/venv 00:47:52 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 00:47:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:47:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:47:52 INFO - Using real prefix '/usr' 00:47:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:47:53 INFO - Installing distribute.............................................................................................................................................................................................done. 00:47:55 INFO - Installing pip.................done. 00:47:55 INFO - Return code: 0 00:47:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:47:55 INFO - Reading from file tmpfile_stdout 00:47:55 INFO - Output received: 00:47:55 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) 00:47:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:55 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 0x7f37b8e99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2636790>, '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 0x2637690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b20>, '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': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', '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 00:47:55 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 00:47:55 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 00:47:55 INFO - Using env: {'DISPLAY': ':0', 00:47:55 INFO - 'HOME': '/home/cltbld', 00:47:55 INFO - 'LANG': 'en_US.UTF-8', 00:47:55 INFO - 'LANGUAGE': 'en_US:en', 00:47:55 INFO - 'LOGNAME': 'cltbld', 00:47:55 INFO - 'MAIL': '/var/mail/cltbld', 00:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:55 INFO - 'MOZ_NO_REMOTE': '1', 00:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:47:55 INFO - 'NO_EM_RESTART': '1', 00:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:55 INFO - 'PWD': '/builds/slave/test', 00:47:55 INFO - 'SHELL': '/bin/bash', 00:47:55 INFO - 'SHLVL': '1', 00:47:55 INFO - 'TERM': 'linux', 00:47:55 INFO - 'TMOUT': '86400', 00:47:55 INFO - 'USER': 'cltbld', 00:47:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', 00:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:55 INFO - '_': '/tools/buildbot/bin/python'} 00:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:55 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 00:47:55 INFO - Cleaning up... 00:47:55 INFO - Return code: 0 00:47:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:55 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 0x7f37b8e99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2636790>, '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 0x2637690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b20>, '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': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', '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 00:47:55 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 00:47:55 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 00:47:55 INFO - Using env: {'DISPLAY': ':0', 00:47:55 INFO - 'HOME': '/home/cltbld', 00:47:55 INFO - 'LANG': 'en_US.UTF-8', 00:47:55 INFO - 'LANGUAGE': 'en_US:en', 00:47:55 INFO - 'LOGNAME': 'cltbld', 00:47:55 INFO - 'MAIL': '/var/mail/cltbld', 00:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:55 INFO - 'MOZ_NO_REMOTE': '1', 00:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:47:55 INFO - 'NO_EM_RESTART': '1', 00:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:55 INFO - 'PWD': '/builds/slave/test', 00:47:55 INFO - 'SHELL': '/bin/bash', 00:47:55 INFO - 'SHLVL': '1', 00:47:55 INFO - 'TERM': 'linux', 00:47:55 INFO - 'TMOUT': '86400', 00:47:55 INFO - 'USER': 'cltbld', 00:47:55 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', 00:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:55 INFO - '_': '/tools/buildbot/bin/python'} 00:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:56 INFO - Downloading/unpacking psutil>=3.1.1 00:47:56 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 00:47:56 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 00:47:56 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 00:47:56 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 00:47:56 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 00:47:56 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 00:47:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:47:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:47:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:47:58 INFO - Installing collected packages: psutil 00:47:58 INFO - Running setup.py install for psutil 00:47:58 INFO - building 'psutil._psutil_linux' extension 00:47:58 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 00:47:58 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 00:47:58 INFO - building 'psutil._psutil_posix' extension 00:47:58 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 00:47:58 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 00:47:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:47:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:47:58 INFO - Successfully installed psutil 00:47:58 INFO - Cleaning up... 00:47:58 INFO - Return code: 0 00:47:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:47:58 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')]} 00:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:58 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')]} 00:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:58 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 0x7f37b8e99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2636790>, '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 0x2637690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b20>, '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': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', '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 00:47:58 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 00:47:58 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 00:47:58 INFO - Using env: {'DISPLAY': ':0', 00:47:58 INFO - 'HOME': '/home/cltbld', 00:47:58 INFO - 'LANG': 'en_US.UTF-8', 00:47:58 INFO - 'LANGUAGE': 'en_US:en', 00:47:58 INFO - 'LOGNAME': 'cltbld', 00:47:58 INFO - 'MAIL': '/var/mail/cltbld', 00:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:58 INFO - 'MOZ_NO_REMOTE': '1', 00:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:47:58 INFO - 'NO_EM_RESTART': '1', 00:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:58 INFO - 'PWD': '/builds/slave/test', 00:47:58 INFO - 'SHELL': '/bin/bash', 00:47:58 INFO - 'SHLVL': '1', 00:47:58 INFO - 'TERM': 'linux', 00:47:58 INFO - 'TMOUT': '86400', 00:47:58 INFO - 'USER': 'cltbld', 00:47:58 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', 00:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:58 INFO - '_': '/tools/buildbot/bin/python'} 00:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:47:58 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 00:47:58 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 00:47:58 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 00:47:58 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 00:47:58 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 00:47:58 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 00:48:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:48:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:48:00 INFO - Installing collected packages: mozsystemmonitor 00:48:00 INFO - Running setup.py install for mozsystemmonitor 00:48:00 INFO - Successfully installed mozsystemmonitor 00:48:00 INFO - Cleaning up... 00:48:00 INFO - Return code: 0 00:48:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:48:00 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')]} 00:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:00 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')]} 00:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:00 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 0x7f37b8e99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2636790>, '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 0x2637690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b20>, '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': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', '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 00:48:00 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 00:48:00 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 00:48:00 INFO - Using env: {'DISPLAY': ':0', 00:48:00 INFO - 'HOME': '/home/cltbld', 00:48:00 INFO - 'LANG': 'en_US.UTF-8', 00:48:00 INFO - 'LANGUAGE': 'en_US:en', 00:48:00 INFO - 'LOGNAME': 'cltbld', 00:48:00 INFO - 'MAIL': '/var/mail/cltbld', 00:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:00 INFO - 'MOZ_NO_REMOTE': '1', 00:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:00 INFO - 'NO_EM_RESTART': '1', 00:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:00 INFO - 'PWD': '/builds/slave/test', 00:48:00 INFO - 'SHELL': '/bin/bash', 00:48:00 INFO - 'SHLVL': '1', 00:48:00 INFO - 'TERM': 'linux', 00:48:00 INFO - 'TMOUT': '86400', 00:48:00 INFO - 'USER': 'cltbld', 00:48:00 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', 00:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:00 INFO - '_': '/tools/buildbot/bin/python'} 00:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:01 INFO - Downloading/unpacking jsonschema==2.5.1 00:48:01 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 00:48:01 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 00:48:01 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 00:48:01 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 00:48:01 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 00:48:01 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 00:48:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:48:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:48:03 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 00:48:03 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 00:48:03 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 00:48:03 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 00:48:03 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 00:48:03 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 00:48:03 INFO - Downloading functools32-3.2.3-2.tar.gz 00:48:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:48:03 INFO - warning: no files found matching '*.txt' 00:48:03 INFO - no previously-included directories found matching 'build' 00:48:03 INFO - no previously-included directories found matching 'dist' 00:48:03 INFO - no previously-included directories found matching '.git*' 00:48:03 INFO - Installing collected packages: jsonschema, functools32 00:48:03 INFO - Running setup.py install for functools32 00:48:03 INFO - warning: no files found matching '*.txt' 00:48:03 INFO - no previously-included directories found matching 'build' 00:48:03 INFO - no previously-included directories found matching 'dist' 00:48:03 INFO - no previously-included directories found matching '.git*' 00:48:03 INFO - Successfully installed jsonschema functools32 00:48:03 INFO - Cleaning up... 00:48:03 INFO - Return code: 0 00:48:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:48:03 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')]} 00:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:03 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')]} 00:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:03 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 0x7f37b8e99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2636790>, '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 0x2637690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b20>, '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': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', '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 00:48:03 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 00:48:03 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 00:48:03 INFO - Using env: {'DISPLAY': ':0', 00:48:03 INFO - 'HOME': '/home/cltbld', 00:48:03 INFO - 'LANG': 'en_US.UTF-8', 00:48:03 INFO - 'LANGUAGE': 'en_US:en', 00:48:03 INFO - 'LOGNAME': 'cltbld', 00:48:03 INFO - 'MAIL': '/var/mail/cltbld', 00:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:03 INFO - 'MOZ_NO_REMOTE': '1', 00:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:03 INFO - 'NO_EM_RESTART': '1', 00:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:03 INFO - 'PWD': '/builds/slave/test', 00:48:03 INFO - 'SHELL': '/bin/bash', 00:48:03 INFO - 'SHLVL': '1', 00:48:03 INFO - 'TERM': 'linux', 00:48:03 INFO - 'TMOUT': '86400', 00:48:03 INFO - 'USER': 'cltbld', 00:48:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', 00:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:03 INFO - '_': '/tools/buildbot/bin/python'} 00:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:48:03 INFO - Cleaning up... 00:48:03 INFO - Return code: 0 00:48:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:48:03 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')]} 00:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:03 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')]} 00:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:03 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 0x7f37b8e99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2636790>, '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 0x2637690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b20>, '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': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', '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 00:48:03 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 00:48:03 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 00:48:03 INFO - Using env: {'DISPLAY': ':0', 00:48:03 INFO - 'HOME': '/home/cltbld', 00:48:03 INFO - 'LANG': 'en_US.UTF-8', 00:48:03 INFO - 'LANGUAGE': 'en_US:en', 00:48:03 INFO - 'LOGNAME': 'cltbld', 00:48:03 INFO - 'MAIL': '/var/mail/cltbld', 00:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:03 INFO - 'MOZ_NO_REMOTE': '1', 00:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:03 INFO - 'NO_EM_RESTART': '1', 00:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:03 INFO - 'PWD': '/builds/slave/test', 00:48:03 INFO - 'SHELL': '/bin/bash', 00:48:03 INFO - 'SHLVL': '1', 00:48:03 INFO - 'TERM': 'linux', 00:48:03 INFO - 'TMOUT': '86400', 00:48:03 INFO - 'USER': 'cltbld', 00:48:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', 00:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:03 INFO - '_': '/tools/buildbot/bin/python'} 00:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:03 INFO - Downloading/unpacking blobuploader==1.2.4 00:48:03 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 00:48:03 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 00:48:03 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 00:48:03 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 00:48:03 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 00:48:03 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 00:48:05 INFO - Downloading blobuploader-1.2.4.tar.gz 00:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:48:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:48:06 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 00:48:06 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 00:48:06 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 00:48:06 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 00:48:06 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 00:48:06 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 00:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:48:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:48:06 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 00:48:06 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 00:48:06 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 00:48:06 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 00:48:06 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 00:48:06 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 00:48:06 INFO - Downloading docopt-0.6.1.tar.gz 00:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:48:06 INFO - Installing collected packages: blobuploader, requests, docopt 00:48:06 INFO - Running setup.py install for blobuploader 00:48:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:48:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:48:06 INFO - Running setup.py install for requests 00:48:07 INFO - Running setup.py install for docopt 00:48:07 INFO - Successfully installed blobuploader requests docopt 00:48:07 INFO - Cleaning up... 00:48:07 INFO - Return code: 0 00:48:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:48:07 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')]} 00:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:07 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')]} 00:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:07 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 0x7f37b8e99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2636790>, '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 0x2637690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b20>, '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': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', '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 00:48:07 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 00:48:07 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 00:48:07 INFO - Using env: {'DISPLAY': ':0', 00:48:07 INFO - 'HOME': '/home/cltbld', 00:48:07 INFO - 'LANG': 'en_US.UTF-8', 00:48:07 INFO - 'LANGUAGE': 'en_US:en', 00:48:07 INFO - 'LOGNAME': 'cltbld', 00:48:07 INFO - 'MAIL': '/var/mail/cltbld', 00:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:07 INFO - 'MOZ_NO_REMOTE': '1', 00:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:07 INFO - 'NO_EM_RESTART': '1', 00:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:07 INFO - 'PWD': '/builds/slave/test', 00:48:07 INFO - 'SHELL': '/bin/bash', 00:48:07 INFO - 'SHLVL': '1', 00:48:07 INFO - 'TERM': 'linux', 00:48:07 INFO - 'TMOUT': '86400', 00:48:07 INFO - 'USER': 'cltbld', 00:48:07 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', 00:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:07 INFO - '_': '/tools/buildbot/bin/python'} 00:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:48:07 INFO - Running setup.py (path:/tmp/pip-0XoUfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:48:07 INFO - Running setup.py (path:/tmp/pip-Ub0Jfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:48:07 INFO - Running setup.py (path:/tmp/pip-iqaRwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:48:07 INFO - Running setup.py (path:/tmp/pip-Gt7nQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:48:07 INFO - Running setup.py (path:/tmp/pip-Wc5PcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:48:08 INFO - Running setup.py (path:/tmp/pip-GInhaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:48:08 INFO - Running setup.py (path:/tmp/pip-GbotDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:48:08 INFO - Running setup.py (path:/tmp/pip-apaCtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:48:08 INFO - Running setup.py (path:/tmp/pip-1sZbVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:48:08 INFO - Running setup.py (path:/tmp/pip-VdABhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:48:08 INFO - Running setup.py (path:/tmp/pip-ENFkZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:48:08 INFO - Running setup.py (path:/tmp/pip-8Pl1HS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:48:08 INFO - Running setup.py (path:/tmp/pip-c15i2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:48:08 INFO - Running setup.py (path:/tmp/pip-ZmO0i8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:48:08 INFO - Running setup.py (path:/tmp/pip-wnEE_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:48:08 INFO - Running setup.py (path:/tmp/pip-C2eTvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:48:08 INFO - Running setup.py (path:/tmp/pip-4wW7RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:48:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:48:08 INFO - Running setup.py install for manifestparser 00:48:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:48:09 INFO - Running setup.py install for mozcrash 00:48:09 INFO - Running setup.py install for mozdebug 00:48:09 INFO - Running setup.py install for mozdevice 00:48:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:48:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:48:09 INFO - Running setup.py install for mozfile 00:48:09 INFO - Running setup.py install for mozhttpd 00:48:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:48:09 INFO - Running setup.py install for mozinfo 00:48:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:48:09 INFO - Running setup.py install for mozInstall 00:48:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:48:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:48:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:48:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:48:09 INFO - Running setup.py install for mozleak 00:48:09 INFO - Running setup.py install for mozlog 00:48:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:48:09 INFO - Running setup.py install for moznetwork 00:48:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:48:10 INFO - Running setup.py install for mozprocess 00:48:10 INFO - Running setup.py install for mozprofile 00:48:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:48:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:48:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:48:10 INFO - Running setup.py install for mozrunner 00:48:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:48:10 INFO - Running setup.py install for mozscreenshot 00:48:10 INFO - Running setup.py install for moztest 00:48:10 INFO - Running setup.py install for mozversion 00:48:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:48:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:48:10 INFO - Cleaning up... 00:48:10 INFO - Return code: 0 00:48:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:48: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')]} 00:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48: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')]} 00:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:10 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 0x7f37b8e99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2636790>, '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 0x2637690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b20>, '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': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', '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 00:48:10 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 00:48:10 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 00:48:10 INFO - Using env: {'DISPLAY': ':0', 00:48:10 INFO - 'HOME': '/home/cltbld', 00:48:10 INFO - 'LANG': 'en_US.UTF-8', 00:48:10 INFO - 'LANGUAGE': 'en_US:en', 00:48:10 INFO - 'LOGNAME': 'cltbld', 00:48:10 INFO - 'MAIL': '/var/mail/cltbld', 00:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:10 INFO - 'MOZ_NO_REMOTE': '1', 00:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:10 INFO - 'NO_EM_RESTART': '1', 00:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:10 INFO - 'PWD': '/builds/slave/test', 00:48:10 INFO - 'SHELL': '/bin/bash', 00:48:10 INFO - 'SHLVL': '1', 00:48:10 INFO - 'TERM': 'linux', 00:48:10 INFO - 'TMOUT': '86400', 00:48:10 INFO - 'USER': 'cltbld', 00:48:10 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', 00:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:10 INFO - '_': '/tools/buildbot/bin/python'} 00:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:48:10 INFO - Running setup.py (path:/tmp/pip-8_9BQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:48:11 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)) 00:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:48:11 INFO - Running setup.py (path:/tmp/pip-xnSk_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:48:11 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)) 00:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:48:11 INFO - Running setup.py (path:/tmp/pip-55t6Yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:48:11 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)) 00:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:48:11 INFO - Running setup.py (path:/tmp/pip-U87UAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:48:11 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)) 00:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:48:11 INFO - Running setup.py (path:/tmp/pip-QXDV_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:48:11 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)) 00:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:48:11 INFO - Running setup.py (path:/tmp/pip-aKXt5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:48:11 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)) 00:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:48:11 INFO - Running setup.py (path:/tmp/pip-06hczq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:48:11 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)) 00:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:48:11 INFO - Running setup.py (path:/tmp/pip-_5SE5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:48:11 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)) 00:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:48:11 INFO - Running setup.py (path:/tmp/pip-r8FqJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:48:11 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)) 00:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:48:11 INFO - Running setup.py (path:/tmp/pip-1j9PVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:48:11 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)) 00:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:48:11 INFO - Running setup.py (path:/tmp/pip-lTbTQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:48:11 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)) 00:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:48:11 INFO - Running setup.py (path:/tmp/pip-XbwZ3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:48:11 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)) 00:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:48:11 INFO - Running setup.py (path:/tmp/pip-kfUxMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:48:11 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)) 00:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:48:11 INFO - Running setup.py (path:/tmp/pip-sXDFDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:48:11 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)) 00:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:48:11 INFO - Running setup.py (path:/tmp/pip-HWrOlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:48:12 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)) 00:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:48:12 INFO - Running setup.py (path:/tmp/pip-HowUNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:48:12 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)) 00:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:48:12 INFO - Running setup.py (path:/tmp/pip-hjStew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:48:12 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)) 00:48:12 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)) 00:48:12 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)) 00:48:12 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)) 00:48:12 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)) 00:48:12 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)) 00:48:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:48:12 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 00:48:12 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 00:48:12 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 00:48:12 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 00:48:12 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 00:48:12 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 00:48:14 INFO - Downloading blessings-1.6.tar.gz 00:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:48:14 INFO - Installing collected packages: blessings 00:48:14 INFO - Running setup.py install for blessings 00:48:14 INFO - Successfully installed blessings 00:48:14 INFO - Cleaning up... 00:48:14 INFO - Return code: 0 00:48:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:48:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:48:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:48:14 INFO - Reading from file tmpfile_stdout 00:48:14 INFO - Current package versions: 00:48:14 INFO - argparse == 1.2.1 00:48:14 INFO - blessings == 1.6 00:48:14 INFO - blobuploader == 1.2.4 00:48:14 INFO - docopt == 0.6.1 00:48:14 INFO - functools32 == 3.2.3-2 00:48:14 INFO - jsonschema == 2.5.1 00:48:14 INFO - manifestparser == 1.1 00:48:14 INFO - mozInstall == 1.12 00:48:14 INFO - mozcrash == 0.17 00:48:14 INFO - mozdebug == 0.1 00:48:14 INFO - mozdevice == 0.48 00:48:14 INFO - mozfile == 1.2 00:48:14 INFO - mozhttpd == 0.7 00:48:14 INFO - mozinfo == 0.9 00:48:14 INFO - mozleak == 0.1 00:48:14 INFO - mozlog == 3.4 00:48:14 INFO - moznetwork == 0.27 00:48:14 INFO - mozprocess == 0.23 00:48:14 INFO - mozprofile == 0.28 00:48:14 INFO - mozrunner == 6.12 00:48:14 INFO - mozscreenshot == 0.1 00:48:14 INFO - mozsystemmonitor == 0.3 00:48:14 INFO - moztest == 0.7 00:48:14 INFO - mozversion == 1.4 00:48:14 INFO - psutil == 3.1.1 00:48:14 INFO - requests == 1.2.3 00:48:14 INFO - wsgiref == 0.1.2 00:48:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:48:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:14 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 0x7f37b8e99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2636790>, '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 0x2637690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b20>, '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': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', '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 00:48:14 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 00:48:14 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 00:48:14 INFO - Using env: {'DISPLAY': ':0', 00:48:14 INFO - 'HOME': '/home/cltbld', 00:48:14 INFO - 'LANG': 'en_US.UTF-8', 00:48:14 INFO - 'LANGUAGE': 'en_US:en', 00:48:14 INFO - 'LOGNAME': 'cltbld', 00:48:14 INFO - 'MAIL': '/var/mail/cltbld', 00:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:14 INFO - 'MOZ_NO_REMOTE': '1', 00:48:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:14 INFO - 'NO_EM_RESTART': '1', 00:48:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:14 INFO - 'PWD': '/builds/slave/test', 00:48:14 INFO - 'SHELL': '/bin/bash', 00:48:14 INFO - 'SHLVL': '1', 00:48:14 INFO - 'TERM': 'linux', 00:48:14 INFO - 'TMOUT': '86400', 00:48:14 INFO - 'USER': 'cltbld', 00:48:14 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', 00:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:14 INFO - '_': '/tools/buildbot/bin/python'} 00:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:14 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)) 00:48:14 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)) 00:48:14 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)) 00:48:14 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)) 00:48:14 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)) 00:48:14 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)) 00:48:14 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)) 00:48:14 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)) 00:48:14 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)) 00:48:14 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)) 00:48:14 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)) 00:48:14 INFO - Cleaning up... 00:48:14 INFO - Return code: 0 00:48:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:48:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f37b8e99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a77b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2636790>, '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 0x2637690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b20>, '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': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', '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 00:48:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:48:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:48:14 INFO - Using env: {'DISPLAY': ':0', 00:48:14 INFO - 'HOME': '/home/cltbld', 00:48:14 INFO - 'LANG': 'en_US.UTF-8', 00:48:14 INFO - 'LANGUAGE': 'en_US:en', 00:48:14 INFO - 'LOGNAME': 'cltbld', 00:48:14 INFO - 'MAIL': '/var/mail/cltbld', 00:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:14 INFO - 'MOZ_NO_REMOTE': '1', 00:48:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:14 INFO - 'NO_EM_RESTART': '1', 00:48:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:14 INFO - 'PWD': '/builds/slave/test', 00:48:14 INFO - 'SHELL': '/bin/bash', 00:48:14 INFO - 'SHLVL': '1', 00:48:14 INFO - 'TERM': 'linux', 00:48:14 INFO - 'TMOUT': '86400', 00:48:14 INFO - 'USER': 'cltbld', 00:48:14 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', 00:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:14 INFO - '_': '/tools/buildbot/bin/python'} 00:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:48:15 INFO - Cleaning up... 00:48:15 INFO - Return code: 0 00:48:15 INFO - Running post-action listener: _resource_record_post_action 00:48:15 INFO - Running post-action listener: _start_resource_monitoring 00:48:15 INFO - Starting resource monitoring. 00:48:15 INFO - [mozharness: 2016-10-06 07:48:15.227782Z] Finished create-virtualenv step (success) 00:48:15 INFO - [mozharness: 2016-10-06 07:48:15.228295Z] Running install step. 00:48:15 INFO - Running pre-action listener: _resource_record_pre_action 00:48:15 INFO - Running main action method: install 00:48:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:48:15 INFO - Reading from file tmpfile_stdout 00:48:15 INFO - Detecting whether we're running mozinstall >=1.0... 00:48:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:48:15 INFO - Reading from file tmpfile_stdout 00:48:15 INFO - Output received: 00:48:15 INFO - Usage: mozinstall [options] installer 00:48:15 INFO - Options: 00:48:15 INFO - -h, --help show this help message and exit 00:48:15 INFO - -d DEST, --destination=DEST 00:48:15 INFO - Directory to install application into. [default: 00:48:15 INFO - "/builds/slave/test"] 00:48:15 INFO - --app=APP Application being installed. [default: firefox] 00:48:15 INFO - mkdir: /builds/slave/test/build/application 00:48:15 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'] 00:48:15 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 00:48:32 INFO - Reading from file tmpfile_stdout 00:48:32 INFO - Output received: 00:48:32 INFO - /builds/slave/test/build/application/firefox/firefox 00:48:32 INFO - Running post-action listener: _resource_record_post_action 00:48:32 INFO - [mozharness: 2016-10-06 07:48:32.613998Z] Finished install step (success) 00:48:32 INFO - [mozharness: 2016-10-06 07:48:32.614242Z] Running run-tests step. 00:48:32 INFO - Running pre-action listener: _resource_record_pre_action 00:48:32 INFO - Running main action method: run_tests 00:48:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:48:32 INFO - Python 2.7.3 00:48:32 INFO - Return code: 0 00:48:32 INFO - grabbing minidump binary from tooltool 00:48:32 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')]} 00:48:32 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 0x2636790>, '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 0x2637690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:48:32 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 00:48:32 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 00:48:32 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 00:48:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:48:32 INFO - Return code: 0 00:48:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:48:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:48:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:48:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:48:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:48:32 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/MN1fdF2DRvWTxztAMoaZug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 00:48:32 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/MN1fdF2DRvWTxztAMoaZug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 00:48:32 INFO - Using env: {'DISPLAY': ':0', 00:48:32 INFO - 'HOME': '/home/cltbld', 00:48:32 INFO - 'LANG': 'en_US.UTF-8', 00:48:32 INFO - 'LANGUAGE': 'en_US:en', 00:48:32 INFO - 'LOGNAME': 'cltbld', 00:48:32 INFO - 'MAIL': '/var/mail/cltbld', 00:48:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:48:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:32 INFO - 'MOZ_NO_REMOTE': '1', 00:48:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:32 INFO - 'NO_EM_RESTART': '1', 00:48:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:32 INFO - 'PWD': '/builds/slave/test', 00:48:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:48:32 INFO - 'SHELL': '/bin/bash', 00:48:32 INFO - 'SHLVL': '1', 00:48:32 INFO - 'TERM': 'linux', 00:48:32 INFO - 'TMOUT': '86400', 00:48:32 INFO - 'USER': 'cltbld', 00:48:32 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807', 00:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:32 INFO - '_': '/tools/buildbot/bin/python'} 00:48:32 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/MN1fdF2DRvWTxztAMoaZug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 00:48:32 INFO - mozversion application_buildid: 20161005213024 00:48:32 INFO - mozversion application_changeset: ad3b71ecafeb0b0366750eb3a771224e05a194ee 00:48:32 INFO - mozversion application_display_name: Nightly 00:48:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:48:32 INFO - mozversion application_name: Firefox 00:48:32 INFO - mozversion application_remotingname: firefox 00:48:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:48:32 INFO - mozversion application_vendor: Mozilla 00:48:32 INFO - mozversion application_version: 52.0a1 00:48:32 INFO - mozversion platform_buildid: 20161005213024 00:48:32 INFO - mozversion platform_changeset: ad3b71ecafeb0b0366750eb3a771224e05a194ee 00:48:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:48:32 INFO - mozversion platform_version: 52.0a1 00:48:32 INFO - using testdate: 1475740112 00:48:32 INFO - actual date: 1475740112 00:48:32 INFO - starting webserver on 'localhost:49100' 00:48:32 INFO - SUITE-START | Running 2 tests 00:48:32 INFO - TEST-START | dromaeo_css 00:48:32 INFO - operating with platform_type : linux_ 00:48:32 INFO - Initialising browser for dromaeo_css test... 00:48:32 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDAlyS5/profile http://localhost:49100/getInfo.html) 00:48:37 INFO - PROCESS | 1939 | __metrics Screen width/height:1600/1200 00:48:37 INFO - PROCESS | 1939 | colorDepth:24 00:48:37 INFO - PROCESS | 1939 | Browser inner width/height: 1024/697 00:48:37 INFO - PROCESS | 1939 | __metrics 00:48:38 INFO - PROCESS | 1939 | 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" 00:48:38 INFO - PROCESS | 1939 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:48:38 INFO - PROCESS | 1939 | console.error: PushService: 00:48:38 INFO - PROCESS | 1939 | stateChangeProcessEnqueue: Error transitioning state 00:48:38 INFO - PROCESS | 1939 | UnknownError 00:48:39 INFO - TEST-INFO | 1939: exit 0 00:48:39 INFO - Browser initialized. 00:48:39 INFO - Running cycle 1/1 for dromaeo_css test... 00:48:39 INFO - TEST-INFO | started process 2079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDAlyS5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:48:51 INFO - PROCESS | 2079 | RSS: Main: 173875200 00:48:51 INFO - PROCESS | 2079 | 00:49:43 INFO - PROCESS | 2079 | 1475740183348 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] 00:51:52 INFO - PROCESS | 2079 | Cycle 1(1): loaded http://localhost:49100/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49100/tests/dromaeo/cssquery-ext.html) 00:51:54 INFO - PROCESS | 2079 | RSS: Main: 267235328 00:51:54 INFO - PROCESS | 2079 | 00:54:56 INFO - PROCESS | 2079 | Cycle 1(1): loaded http://localhost:49100/tests/dromaeo/cssquery-ext.html (next: http://localhost:49100/tests/dromaeo/cssquery-jquery.html) 00:54:57 INFO - PROCESS | 2079 | RSS: Main: 275607552 00:54:57 INFO - PROCESS | 2079 | 00:57:59 INFO - PROCESS | 2079 | Cycle 1(1): loaded http://localhost:49100/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49100/tests/dromaeo/cssquery-mootools.html) 00:58:00 INFO - PROCESS | 2079 | RSS: Main: 225796096 00:58:00 INFO - PROCESS | 2079 | 01:01:02 INFO - PROCESS | 2079 | Cycle 1(1): loaded http://localhost:49100/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49100/tests/dromaeo/cssquery-prototype.html) 01:01:02 INFO - PROCESS | 2079 | RSS: Main: 246935552 01:01:02 INFO - PROCESS | 2079 | 01:04:05 INFO - PROCESS | 2079 | Cycle 1(1): loaded http://localhost:49100/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49100/tests/dromaeo/cssquery-yui.html) 01:04:05 INFO - PROCESS | 2079 | RSS: Main: 220295168 01:04:05 INFO - PROCESS | 2079 | 01:07:08 INFO - PROCESS | 2079 | Cycle 1(1): loaded http://localhost:49100/tests/dromaeo/cssquery-yui.html (next: http://localhost:49100/tests/dromaeo/cssquery-dojo.html) 01:07:09 INFO - PROCESS | 2079 | RSS: Main: 308031488 01:07:09 INFO - PROCESS | 2079 | 01:07:09 INFO - PROCESS | 2079 | __start_tp_report 01:07:09 INFO - PROCESS | 2079 | _x_x_mozilla_page_load 01:07:09 INFO - PROCESS | 2079 | _x_x_mozilla_page_load_details 01:07:09 INFO - PROCESS | 2079 | |i|pagename|runs| 01:07:09 INFO - PROCESS | 2079 | |0;dojo.html;2975.598294230279;3010.894618688345;3011.7138871807183;3044.2389402649337;3057.908262752117;5037.093323201822;5122.92315615266;5144.948550514494;5224.503672151149;5239.240310155025;5112.8977420451565;5184.766685499152;5212.582993360532;5252.842414727555;5268.525832675058;4676.205045142334;4694.2723877799;4711.787969541362;4751.928721069186;4763.404574428197;4817.51824817519;4859.781309841048;4866.440359358684;4889.804407823701;4906.582940450066;4636.049609830011;4670;4791.976040119812;4851.539103785152;4873.31773551703;4619.584237418615;4660.650451216173;4694.835680751192;4711.740854253015;4718.976405117953;4647.86056418308;4664.510226426244;4671.112488627184;4714.104320179155;4769.117713223065;5174.6636468629795;5193.376794784613;5195.480451954812;5201.037808005531;5267.394249661262;5343.545798607123;5401.864953376158;5449.427810079924;5486.396496385394;5528.364238112628;5534.972325138388;5546.750396232179;5561.499465048165;5566.944330556683;5592.496675299242;5159.922601160985;5180.507851754077;5184.585233181337;5204.947950520522;5266.289050978107;5417.8103766367985;5484.588655850827;5497.230387745639;5574.024545704486;5574.136008918543;5351.357837059578;5431.8098866539485;5436.864078398072;5516.696581687966;5517;5508.834734957958;5531.502164805187;5532.640378375393;5579.944200558024;5600.159976003632;5456;5485.6434331768305;5503.284573005483;5505.862353441196;5509.559235261169;5314.521693047567;5341.305630268041;5372.5970552207955;5375.892482150335;5574.996500629844;4222.345536441856;4223.070924396628;4223.577642235752;4224.957750422456;4246.617804397619;3837.213371258885;3882.9611703883165;3895.8636447724193;3909.2181563687377;3916.7845768483007;5240.737963101829;5243.790248390098;5244.134717771525;5247.7113758743635;5303.655262408009;5563.638363506359;5570.053090974544;5572.108462645957;5573.996680597531;5637.830865074055;5065.468125846806;5106.234064890296;5163.277141200235;5212.55693266069;5234.633575649744;4841;4845.345878306454;4849.58778503824;4877.292792545132;4899.363082799213;5688.431156884279;5756.251687280543;5763.85590360236;5767.04843700793;5825.533957283492;5347.144456886879;5401.513863752281;5478.123500240102;5550.47270509301;5561.165825126263;5726.0838265877255;5785.768569257182;5788.21859049023;5850.444207800252;5865.032269675627;5435.184722291688;5440.211169380338;5441.591880609049;5442.12925931849;5446.1558458439;5354.303940487712;5405.405405405481;5567.137093750475;5583.972080139736;5643.915341269966;5356.839294821161;5399.136138218023;5422.376426710979;5447.727613619382;5513.007658621486;5332.413434522122;5373.247745315737;5382.569394448356;5388.757505912322;5431.972840135774;5158.845234642967;5249.501297376743;5290.206469029523;5304.177852432879;5372.892542149057;5279.9472005280995;5367.329083864517;5421.159720243369;5427.158790387496;5521.723913804374;5319.601029922848;5321.521063104339;5325.627206095536;5326.6537675050995;5330.360356757214 01:07:09 INFO - PROCESS | 2079 | |1;ext.html;568.3407247592792;585.096026638843;593.3117583603022;595.4492094812299;601.5999360425318;30750.231244218907;31526.84236578817;42143.36784948228;43340;43343.783281083626;44047.11905761883;44496.33255501162;44529.777351113196;44533;44577.777111114396;8849.424787388814;9000.59497322622;9002.504862232574;9007.189352958232;9009.234215091725;7934.880976785324;8131.268185863271;8179.836403271931;8734.432261902955;10435.843462348072;10567.630132945349;10976.176786741027;10977.792442831322;10978;10978.615748448807;10760.73098172548;10823.783524329468;10842.241043126984;10844.403557804317;10845.51195196214;7897.526148431112;8122.147174546647;10255.179585633132;10643;10713.625023124232;38468.615313846785;41483.377749333784;41518.792406038076;41591.168176636296;41607;3111.6266048074376;3112.439760843047;3122.4847900096456;3136.357046805422;3167.556542084087;31232.21919452009;31659.84170079135;31936;31981.200469988435;32847;3931.194105208454;3984.9601503984877;3997.6402123808707;4088.8364465421346;4187.450643262013;323264;324676;325175;326026;326627.36686316656;34343.484847727304;35197.472037919455;54982.45017549773;55021.497850215455;55308;37126;37306.62693373032;37322;37403;37422.62577374246;14863.33115009827;15067.321970511353;15186.088834669956;15187.468438604596;15204.771928421083;10974.890251097388;11217.15871309655;11224.158188135922;11229.606963756229;11231.887681123084;7937.126916039231;8156.796080098045;8323.875141872877;8533.359998000175;8609.22516973463;3288.3423315337027;3308.2887179256577;3349.179451034512;3366.646502117291;3404.5233667286598;985.8570507276548;987.629638885418;1006.174936552035;1030.283952652914;1076.2896488317829;31234.375312493623;31313.8434307827;31319.686803132132;31345.686543134732;31611.84194079015;1043.8642976413169;1051.8264486359817;1103.3600511703353;1134.880837512066;1144.3591588710349;15581.610459738597;16364.509064728078;16380.83619163793;16435.506934791738;16823.747643785355;460290;464004;464159;464867;465247;48837;49702.25446618304;54907.45092549103;57214.14178787322;57919;1219.4146809531296;1283.9486420543074;1319.6239071864472;1320.3332317179763;1321.3459337627935;29866.35735034594;32110.678893211705;32249.193770154994;32289.869854554978;32322.83838580792;48236;48637.75681121572;48762.5123748758;48794.75602621964;48803.26795098148;413006;422458;431105;432577;660451;42041.1591768169;42253;42275;42288;42778;46267.305990410845;46707;46906.76546617245;46959.29561056518;47668;38504.229915400974;38596.6140338593;38613;40835.79582102071;41077.1784564313;39136.217275653755;40137.1972560553;40145.59854401535;40294.79852600718;40713.59286407098;38350.61649383471;39000.804995975974;39512.60487395089;39943;40386;33089.834550827094;35353.82323088368;35357.524973251624;35388.64611353853;35959.62827620384;27076.1877143686;27396;27442.862785685942;27685.861570692017;27707 01:07:09 INFO - PROCESS | 2079 | |2;jquery.html;381.2280132731221;389.8615991323082;397.38802244543405;398.43820213498964;422.90696046869675;17361.218745156468;18801.81198188018;18931.33740319089;18940.81059189408;18991.810081899177;17591.472255832312;18286.542836429096;18425.170867310968;18759.249630014816;18931.62136757264;5667.206591077253;5834.27071616048;5864.296284445851;5908.231929849114;5914.083317085837;5610.07433773429;5850.648961062328;5852.151438041481;5852.912206316909;5853.209816674737;5527.364353099405;5761;5808.04167312395;5812.505936995361;5819.709014549277;5874.9412505874825;5904.704764761745;5913.586048976574;5917.615355001911;5919.319278282988;5656.688882111483;5867;5900.43945825146;5907.2911250650195;5908.113782932552;13949.721005579933;14072.507462238773;14089.85910140906;14266.429342826275;14343;2240.708707867983;2274.3518097342344;2461.655368248447;2524.861132637704;2535.594304911205;10168.542415591242;10485.423301718403;10528.263021588491;10857.619983300625;13270.14218009479;1861.795202527721;1900.1544312780818;1908.3225454963565;1923.913423895928;1964.4401345616432;74165;76264.23735762626;77251.61374193092;77558.61220693917;79086;10236.744081398025;10246.743831404274;10506.684799456028;10730.776149833078;10990.505427255792;15326.770098448533;15344.693106138038;15362.692746145014;15375.923120384326;15385.769213461806;7823.9608801956765;8123.390745694097;8212.794680133044;8281.875771863426;8307.709230176915;7705.499142555716;7745.806354841061;7781.26078022587;8029.678812847537;8085.919140808634;4674.626029917598;4691.929621055687;4757.167495688241;4791.425028996543;4857.198562237191;1875.1561797191318;1925.7015162649811;1970.5861769028666;2015.2442833937273;2035.2266138867433;435.7407342631129;438.6797637724415;452.64241249413254;814.8696208606594;878.3587980773943;11921.582744603897;18032.188551515213;19230.903845480683;20036.69944950827;20732;941.2893265584577;947.5830634520927;961.4375590279625;999.4702807512031;1003.6336737091056;10426.530806113744;10968.341899486057;10991.61529346485;11070.114390848712;11090.611828585961;453561;454281;461545;463268;467547;88637.55681221552;90441;90569.64145537822;90905.54547227222;90932.54533727422;998.5606333213362;1073.2111897755144;1101.6970333158445;1102.685734565645;1104.4422566603814;16459.91770041142;17037.14814259307;17364.652706946043;17382.565435864206;17445.47663570095;40204.597954020086;40903.1819363617;41071.7946410266;41411;41563.7921810389;54133.72933135309;56147.719261405065;56852.71573642105;58087.70956145192;58708.41291587029;7876.921230787848;8181.590920453835;8462.619182136941;8554.871676924726;8593.785155370915;8898.688545900863;11356.94321528387;11684.240524365889;12475.5009799607;12544.372781361079;10875.836862446911;10926.945365273123;11184.720381990515;11238.55045798159;11536.36549989725;10438.26932114775;10563.419011954416;10603.151747860307;10865.402402867601;10988.945055274673;10489.527971241465;10786.352818830896;10806;10972.561097556008;10994.780104398027;8128.105908349959;8144.389170812095;8244.340452763885;8394.748157555283;8553.871691924502;9169.266458683423;10500.842487362543;10774.393983972566;10782.838257426301;10947.781044378908 01:07:09 INFO - PROCESS | 2079 | |3;mootools.html;1355.4307190979787;1472.32273154349;1508.0574640849468;1638.7705721199027;1802.1079565615023;7480.663370148342;8271.586420678965;8476.66093356265;8489.811426400302;8705.260052895495;8491.193336633025;8537;8554.70058547951;8562.957185214082;8565.785855353619;2275.9317220483413;2291.324059402472;2307.3193407944614;2315.340128063502;2317.2932255662017;2225.94435139122;2254.7068881045443;2277.7152855893014;2279.0541925101147;2283.7716228377194;2131.4990977120365;2140.1867290429614;2146.7209262795814;2238.9776102238934;2271.954560908781;2168.566286742642;2191.9561608767895;2196.011794692387;2200.427888748921;2213.0262684418885;2181.4873504726534;2185.3553201805507;2199.1533259694975;2206.1616585697493;2216.9778302217096;8493.745187644381;8531.402801803877;8583.098774628637;8600.956995214983;8702.086280940473;5153.3558305211845;5362.35651721792;5367.919481207785;5372.0330340538685;5375.462453754632;3239.659835717263;3282.786618869766;3309.040378290317;3317.092671713774;3319.850606722703;1111.1610733895857;1117.3519358771894;1123.3428444360059;1127.9887201127965;1150.9942450287695;12075.93962030193;12083.516659333616;12150.513979440811;12185.207961482476;12188.268703877708;4158.355454904495;4374.58441448062;4455.331700244924;4535.206338890681;4546.04533048057;9500.334976551576;9511.762205944768;9523.428594284227;9532.23742100644;9536.427814331162;5153.304303918998;5159.380874295109;5189.143791274473;5193.792248310026;5198.740062996835;4310.870673879788;4444.333349997526;4696.718196908197;4813.133635945564;4861.829835955725;3599.712023038203;3644.1982763791925;3710.703143748494;3735.813209339522;3753.530808648919;1115.642994241835;1117.7596816684452;1130.1072152999202;1130.4347826086957;1136.693092864922;792.0297635396593;925.2829057480371;926.5830376330678;957.1003256938594;961.0821665309612;5932.940670593239;5934.821955341346;6020.217371741734;6054.424829641177;6380.170577824853;901.9143181397887;904.452806052342;934.9252059835197;948.3977674176809;964.6575465709572;3794.317022935898;3888.941665875014;4028.395740638869;4106.958930410718;4159.480064991876;10688.51901664427;10967.561297548169;11125.276857004268;11128.944355278334;11169.664910052712;10846.18653600983;10950.835737463944;11048.447577621087;11052.668419947415;11063;8054.919450805534;8120.228578285053;8151.30713889326;8232.094469608339;8248.587570621445;5782.710864456676;5783.277090363705;5861.677607731615;5876.324222714443;5970.910436343545;9721.270904682036;9745.26910481731;9811.705648830546;9843.753906152404;10078.848817267894;10142.898571014195;10187.490625468845;10240.897591023995;10307.072363487323;10334.224933129895;6601.108850305147;6980.825479362853;7316.304951029643;7350.595717235603;7498.662560184914;8584.785380365542;8725;8727.476351418934;8737.519436431057;8742.082081381617;7578.696852125853;7633.389328853789;7790.065192176975;7894.921050789419;7939;7187.209406965334;7295.7081716732855;7313.122425308997;7378.188399275968;7383.372413344926;6506.25178104524;6628.403443690091;6629.105070815378;6631.966840165768;6648.634325112165;4953.529414705597;5056.115179843586;5068.771905264198;5168.043911876315;5213.400458947118;4881.414230292387;4909.901801963869;4939.851804445872;5056.115179843586;5059.898802023865 01:07:09 INFO - PROCESS | 2079 | |4;prototype.html;324.1275408605064;336.1277484926615;342.19925374623375;343.1592598134569;345.04938893348833;5079.441261461246;5213.644452442364;5276.868078298045;5327.813526526573;5333.519983201511;5100.540951314381;5215.843524694255;5220.034293655676;5245.947540524594;5251.264822924793;4181.958180418187;4192.454980852485;4195.4545909031785;4196.412502249687;4212.241796476641;4099.836006559734;4151.169766046788;4163.354680024601;4200.873973780776;4211.7472951623;4153.8338466461455;4154.169166166764;4165.146145040275;4173.269677806372;4173.791310434482;4065.939010914809;4129;4132.214879172948;4139.586041395852;4145.398917156996;3685.68671662909;3690.630936906288;3695.4087346024507;3696.131409118855;3725.2549490102087;4902.166631672624;5053.823116190915;5063.468335824722;5078.593712503028;5097.5667068299235;4714.151452738506;4727.409073865767;4744.7627618618935;4747.620190384761;4755.881102972418;5462.562994960394;5465.262189604392;5470.8937059232085;5471.616986810925;5482.780688772445;3789.4694742736037;3978.7214894957365;3999.9400458649156;4001.7198796084285;4009.4787677601726;5677.914831277493;5688.203651488795;5705.6576605404225;5731.541476681897;5732.627379220337;4076.5923407658997;4077.4087757275624;4090.4886889138857;4098.303288440972;4100.384942258625;3914.1584559319313;4090.775007374623;4122.154958233555;4126.319157339066;4151.958480415217;4665.533446655375;4678.3216433616935;4685.835995740201;4690.64820138491;4708.858734237979;5513.448655134454;5514.476124768141;5516.172574113915;5524.447555244524;5529.861753456195;1329.860364661716;1349.8447678517095;1403.4596680277962;1413.1591702936737;1415.1933397963062;879.9208071273616;915.4781774388534;923.4044041593135;924.8289066522715;930.4882314726873;4543.750468621156;4565.931511027337;4606.286025666027;4633.212353899845;4657.301404789241;4786.976065119652;4828.420589529209;4855.36880205571;4862.756862156949;4878.219484882402;4446.488653804854;4596.35651008859;4624.468186158568;4631.328457373662;4637.333533218413;2568.345072006664;2594.818362714592;2626.9772275347873;2635.7891368690457;2641.841489510597;4995.525425084611;5004.599632029429;5006.599472042228;5016.097102521581;5034.018366418513;4675.859724208279;4939.2838038484215;4964.90070198594;4978.701277923336;5012.924806127911;5013.596193065874;5023.949760502348;5044.218146187347;5068.290439338495;5090.872728181825;4812.759362031955;4824.34871292371;4862.465128835896;4867.513248675245;4875.390576177978;4752.485139117783;4768.260919557474;4839.419269687519;4847.781849816696;5242.554382877498;5815.505682017076;5825.50483208932;5829.47534721877;5847.7368518417625;5851.707414629166;4106.240345535966;4109.9589004109575;4125.463689720317;4135.29699951015;4136.131412403309;5445.754941027584;5643.1535269709875;5711.228984087095;5711.714864155531;5715.657060576379;5533.723313834212;5535.557155427637;5540.501354878081;5546.7781288748;5571.573482308432;5544.283301182472;5561.916571251515;5562.721863906708;5571.637843540157;5588.552915766648;5220.269162317354;5363.498220498267;5405.324334458192;5464.535514481155;5485.204645326326;5496.477834605706;5540.418256083053;5554.389017208023;5559.332880054258;5569.721513924206;5214.530692237717;5410.836670115787;5451.754671039734;5466.753996070107;5536.584756143225 01:07:09 INFO - PROCESS | 2079 | |5;yui.html;673.3535805626598;778.8714862047763;792.805762588166;805.9314958228554;815.1725998111914;14814.925925370371;16228.594285142877;16241.756373654405;16311.429099981504;16351.182440877968;13945.163290202596;14668.193249371281;14701.485448009322;14822.258887055657;14873.256337183151;797.5852556670513;803.6664784114586;804.6258489802241;804.7666176808718;805.1304591041691;665.6605131383005;674.8447856992894;800.7437619961614;810.307187354812;819.983600327993;860.9526476043815;862.2886118951858;863.313665635821;863.4128792421151;864.7794812322849;858.8153546987428;860.1312674199073;860.1785295043281;860.2601762484289;860.3332417376521;508.1412413021981;517.3223077768135;615.4153554123556;621.6487684458267;628.8427893026743;13435.32823358838;13479.393427295796;13506.662333441742;13553.39009744554;13565.932170339183;13127.737445251138;13140.802887956688;13208.86791132086;13436.865631343659;14474.203918784462;12346.122742384754;12384.690382740413;12595.748085038247;13012.414441350162;13432.664183395396;4248.086661367821;4317.568243175689;4353.325234588644;4381.255186618282;4445.933311000337;73183;73186.26813731901;74180.62909685471;75321.24678753197;75384;10365.585376585002;10422.947885260524;10431.321964072462;10572.841407378895;10880.891191087987;18357;18367.35714249995;18371.72442413365;18389.63220735578;18405.5398615033;7555.282248186413;7735.22647735222;7774.416918731118;7941.6029198539845;7967.960160199162;4258.403823464718;4293.104473470368;4386.473623165177;4439.045605194899;4442.4669039715445;3379.645137260552;3534.0281422608987;3540.238848647553;3540.398132317512;3541.752077354612;598.35676647604;614.50839328537;624.2228425610144;626.2453743239386;633.5628416392674;479.85844175968174;491.68532139430795;492.6817881567639;596.5496050481859;597.3501903370403;8387.538685372363;8562.272206862486;8584.484930904166;8669.176428239307;8888.511131887679;571.665575638248;576.4869266352949;589.0608630334665;590.5246276747259;632.7342516143231;4122.896927576835;4146.543636986331;4172.77049762266;4305.784710764449;4483.932741008887;71526.64236678783;73540;73902.63048684722;74197;74307;101528.41593712269;106871.46564267285;108197.45901270601;111849;113113;69759;92274.53862730644;93538.5323073394;94427.52786236025;94770.0522994775;8159;8411.537365444714;8940.68707595231;9020.909790902007;9152.202406958848;47845.521544784104;48422.75788621034;48621.756891215315;49073.5092649069;49547.752261238464;52373.21440178324;63506.68246658737;65900.34099658942;66830.66584667045;68964.31035689579;10674.519646615765;10771.192160588143;11163.44182790841;11536.192466527262;11891.464884080064;13015.934920325337;13046.41291141882;13576.93211533936;13579.253141077335;13627.114237574922;12450.63043065244;12681;12708.173968692376;12708.682282943;12985.935070324587;12246.448909798903;12307.26156430617;12543.3101179436;12604.243745375306;12704.237745735285;12232.204906681038;12430.192037517532;13016.544420945222;13102.978943237615;13334.599962001155;9575.664851730156;9995.500224988577;10284.2801003932;10645.946770266099;10826.837597435888;10078.8488172676;10168.644097456849;10512.632057877938;10739.785204295715;11003.834942476029 01:07:09 INFO - PROCESS | 2079 | __end_tp_report 01:07:09 INFO - PROCESS | 2079 | __start_cc_report 01:07:09 INFO - PROCESS | 2079 | _x_x_mozilla_cycle_collect,1219 01:07:09 INFO - PROCESS | 2079 | __end_cc_report 01:07:09 INFO - PROCESS | 2079 | __startTimestamp1475741229219__endTimestamp 01:07:09 INFO - PROCESS | 2079 | 01:07:09 INFO - PROCESS | 2079 | ------- Summary: start ------- 01:07:09 INFO - PROCESS | 2079 | Number of tests: 6 01:07:09 INFO - PROCESS | 2079 | 01:07:09 INFO - PROCESS | 2079 | [#0] dojo.html Cycles:165 Average:5141.96 Median:5321.52 stddev:562.26 (10.6%) stddev-sans-first:537.69 01:07:09 INFO - PROCESS | 2079 | Values: 2975.6 3010.9 3011.7 3044.2 3057.9 5037.1 5122.9 5144.9 5224.5 5239.2 5112.9 5184.8 5212.6 5252.8 5268.5 4676.2 4694.3 4711.8 4751.9 4763.4 4817.5 4859.8 4866.4 4889.8 4906.6 4636.0 4670.0 4792.0 4851.5 4873.3 4619.6 4660.7 4694.8 4711.7 4719.0 4647.9 4664.5 4671.1 4714.1 4769.1 5174.7 5193.4 5195.5 5201.0 5267.4 5343.5 5401.9 5449.4 5486.4 5528.4 5535.0 5546.8 5561.5 5566.9 5592.5 5159.9 5180.5 5184.6 5204.9 5266.3 5417.8 5484.6 5497.2 5574.0 5574.1 5351.4 5431.8 5436.9 5516.7 5517.0 5508.8 5531.5 5532.6 5579.9 5600.2 5456.0 5485.6 5503.3 5505.9 5509.6 5314.5 5341.3 5372.6 5375.9 5575.0 4222.3 4223.1 4223.6 4225.0 4246.6 3837.2 3883.0 3895.9 3909.2 3916.8 5240.7 5243.8 5244.1 5247.7 5303.7 5563.6 5570.1 5572.1 5574.0 5637.8 5065.5 5106.2 5163.3 5212.6 5234.6 4841.0 4845.3 4849.6 4877.3 4899.4 5688.4 5756.3 5763.9 5767.0 5825.5 5347.1 5401.5 5478.1 5550.5 5561.2 5726.1 5785.8 5788.2 5850.4 5865.0 5435.2 5440.2 5441.6 5442.1 5446.2 5354.3 5405.4 5567.1 5584.0 5643.9 5356.8 5399.1 5422.4 5447.7 5513.0 5332.4 5373.2 5382.6 5388.8 5432.0 5158.8 5249.5 5290.2 5304.2 5372.9 5279.9 5367.3 5421.2 5427.2 5521.7 5319.6 5321.5 5325.6 5326.7 5330.4 01:07:09 INFO - PROCESS | 2079 | 01:07:09 INFO - PROCESS | 2079 | [#1] ext.html Cycles:180 Average:56977.12 Median:37886.62 stddev:113916.10 (300.7%) stddev-sans-first:114156.94 01:07:09 INFO - PROCESS | 2079 | Values: 568.3 585.1 593.3 595.4 601.6 30750.2 31526.8 42143.4 43340.0 43343.8 44047.1 44496.3 44529.8 44533.0 44577.8 8849.4 9000.6 9002.5 9007.2 9009.2 7934.9 8131.3 8179.8 8734.4 10435.8 10567.6 10976.2 10977.8 10978.0 10978.6 10760.7 10823.8 10842.2 10844.4 10845.5 7897.5 8122.1 10255.2 10643.0 10713.6 38468.6 41483.4 41518.8 41591.2 41607.0 3111.6 3112.4 3122.5 3136.4 3167.6 31232.2 31659.8 31936.0 31981.2 32847.0 3931.2 3985.0 3997.6 4088.8 4187.5 323264.0 324676.0 325175.0 326026.0 326627.4 34343.5 35197.5 54982.5 55021.5 55308.0 37126.0 37306.6 37322.0 37403.0 37422.6 14863.3 15067.3 15186.1 15187.5 15204.8 10974.9 11217.2 11224.2 11229.6 11231.9 7937.1 8156.8 8323.9 8533.4 8609.2 3288.3 3308.3 3349.2 3366.6 3404.5 985.9 987.6 1006.2 1030.3 1076.3 31234.4 31313.8 31319.7 31345.7 31611.8 1043.9 1051.8 1103.4 1134.9 1144.4 15581.6 16364.5 16380.8 16435.5 16823.7 460290.0 464004.0 464159.0 464867.0 465247.0 48837.0 49702.3 54907.5 57214.1 57919.0 1219.4 1283.9 1319.6 1320.3 1321.3 29866.4 32110.7 32249.2 32289.9 32322.8 48236.0 48637.8 48762.5 48794.8 48803.3 413006.0 422458.0 431105.0 432577.0 660451.0 42041.2 42253.0 42275.0 42288.0 42778.0 46267.3 46707.0 46906.8 46959.3 47668.0 38504.2 38596.6 38613.0 40835.8 41077.2 39136.2 40137.2 40145.6 40294.8 40713.6 38350.6 39000.8 39512.6 39943.0 40386.0 33089.8 35353.8 35357.5 35388.6 35959.6 27076.2 27396.0 27442.9 27685.9 27707.0 01:07:09 INFO - PROCESS | 2079 | 01:07:09 INFO - PROCESS | 2079 | [#2] jquery.html Cycles:180 Average:27486.82 Median:397.91 stddev:75970.04 (19092.1%) stddev-sans-first:76155.89 01:07:09 INFO - PROCESS | 2079 | Values: 381.2 389.9 397.4 398.4 422.9 17361.2 18801.8 18931.3 18940.8 18991.8 17591.5 18286.5 18425.2 18759.2 18931.6 5667.2 5834.3 5864.3 5908.2 5914.1 5610.1 5850.6 5852.2 5852.9 5853.2 5527.4 5761.0 5808.0 5812.5 5819.7 5874.9 5904.7 5913.6 5917.6 5919.3 5656.7 5867.0 5900.4 5907.3 5908.1 13949.7 14072.5 14089.9 14266.4 14343.0 2240.7 2274.4 2461.7 2524.9 2535.6 10168.5 10485.4 10528.3 10857.6 13270.1 1861.8 1900.2 1908.3 1923.9 1964.4 74165.0 76264.2 77251.6 77558.6 79086.0 10236.7 10246.7 10506.7 10730.8 10990.5 15326.8 15344.7 15362.7 15375.9 15385.8 7824.0 8123.4 8212.8 8281.9 8307.7 7705.5 7745.8 7781.3 8029.7 8085.9 4674.6 4691.9 4757.2 4791.4 4857.2 1875.2 1925.7 1970.6 2015.2 2035.2 435.7 438.7 452.6 814.9 878.4 11921.6 18032.2 19230.9 20036.7 20732.0 941.3 947.6 961.4 999.5 1003.6 10426.5 10968.3 10991.6 11070.1 11090.6 453561.0 454281.0 461545.0 463268.0 467547.0 88637.6 90441.0 90569.6 90905.5 90932.5 998.6 1073.2 1101.7 1102.7 1104.4 16459.9 17037.1 17364.7 17382.6 17445.5 40204.6 40903.2 41071.8 41411.0 41563.8 54133.7 56147.7 56852.7 58087.7 58708.4 7876.9 8181.6 8462.6 8554.9 8593.8 8898.7 11356.9 11684.2 12475.5 12544.4 10875.8 10926.9 11184.7 11238.6 11536.4 10438.3 10563.4 10603.2 10865.4 10988.9 10489.5 10786.4 10806.0 10972.6 10994.8 8128.1 8144.4 8244.3 8394.7 8553.9 9169.3 10500.8 10774.4 10782.8 10947.8 01:07:09 INFO - PROCESS | 2079 | 01:07:09 INFO - PROCESS | 2079 | [#3] mootools.html Cycles:180 Average:5671.04 Median:5056.12 stddev:3260.20 (64.5%) stddev-sans-first:3253.22 01:07:09 INFO - PROCESS | 2079 | Values: 1355.4 1472.3 1508.1 1638.8 1802.1 7480.7 8271.6 8476.7 8489.8 8705.3 8491.2 8537.0 8554.7 8563.0 8565.8 2275.9 2291.3 2307.3 2315.3 2317.3 2225.9 2254.7 2277.7 2279.1 2283.8 2131.5 2140.2 2146.7 2239.0 2272.0 2168.6 2192.0 2196.0 2200.4 2213.0 2181.5 2185.4 2199.2 2206.2 2217.0 8493.7 8531.4 8583.1 8601.0 8702.1 5153.4 5362.4 5367.9 5372.0 5375.5 3239.7 3282.8 3309.0 3317.1 3319.9 1111.2 1117.4 1123.3 1128.0 1151.0 12075.9 12083.5 12150.5 12185.2 12188.3 4158.4 4374.6 4455.3 4535.2 4546.0 9500.3 9511.8 9523.4 9532.2 9536.4 5153.3 5159.4 5189.1 5193.8 5198.7 4310.9 4444.3 4696.7 4813.1 4861.8 3599.7 3644.2 3710.7 3735.8 3753.5 1115.6 1117.8 1130.1 1130.4 1136.7 792.0 925.3 926.6 957.1 961.1 5932.9 5934.8 6020.2 6054.4 6380.2 901.9 904.5 934.9 948.4 964.7 3794.3 3888.9 4028.4 4107.0 4159.5 10688.5 10967.6 11125.3 11128.9 11169.7 10846.2 10950.8 11048.4 11052.7 11063.0 8054.9 8120.2 8151.3 8232.1 8248.6 5782.7 5783.3 5861.7 5876.3 5970.9 9721.3 9745.3 9811.7 9843.8 10078.8 10142.9 10187.5 10240.9 10307.1 10334.2 6601.1 6980.8 7316.3 7350.6 7498.7 8584.8 8725.0 8727.5 8737.5 8742.1 7578.7 7633.4 7790.1 7894.9 7939.0 7187.2 7295.7 7313.1 7378.2 7383.4 6506.3 6628.4 6629.1 6632.0 6648.6 4953.5 5056.1 5068.8 5168.0 5213.4 4881.4 4909.9 4939.9 5056.1 5059.9 01:07:09 INFO - PROCESS | 2079 | 01:07:09 INFO - PROCESS | 2079 | [#4] prototype.html Cycles:180 Average:4476.08 Median:4862.61 stddev:1289.23 (26.5%) stddev-sans-first:1254.61 01:07:09 INFO - PROCESS | 2079 | Values: 324.1 336.1 342.2 343.2 345.0 5079.4 5213.6 5276.9 5327.8 5333.5 5100.5 5215.8 5220.0 5245.9 5251.3 4182.0 4192.5 4195.5 4196.4 4212.2 4099.8 4151.2 4163.4 4200.9 4211.7 4153.8 4154.2 4165.1 4173.3 4173.8 4065.9 4129.0 4132.2 4139.6 4145.4 3685.7 3690.6 3695.4 3696.1 3725.3 4902.2 5053.8 5063.5 5078.6 5097.6 4714.2 4727.4 4744.8 4747.6 4755.9 5462.6 5465.3 5470.9 5471.6 5482.8 3789.5 3978.7 3999.9 4001.7 4009.5 5677.9 5688.2 5705.7 5731.5 5732.6 4076.6 4077.4 4090.5 4098.3 4100.4 3914.2 4090.8 4122.2 4126.3 4152.0 4665.5 4678.3 4685.8 4690.6 4708.9 5513.4 5514.5 5516.2 5524.4 5529.9 1329.9 1349.8 1403.5 1413.2 1415.2 879.9 915.5 923.4 924.8 930.5 4543.8 4565.9 4606.3 4633.2 4657.3 4787.0 4828.4 4855.4 4862.8 4878.2 4446.5 4596.4 4624.5 4631.3 4637.3 2568.3 2594.8 2627.0 2635.8 2641.8 4995.5 5004.6 5006.6 5016.1 5034.0 4675.9 4939.3 4964.9 4978.7 5012.9 5013.6 5023.9 5044.2 5068.3 5090.9 4812.8 4824.3 4862.5 4867.5 4875.4 4752.5 4768.3 4839.4 4847.8 5242.6 5815.5 5825.5 5829.5 5847.7 5851.7 4106.2 4110.0 4125.5 4135.3 4136.1 5445.8 5643.2 5711.2 5711.7 5715.7 5533.7 5535.6 5540.5 5546.8 5571.6 5544.3 5561.9 5562.7 5571.6 5588.6 5220.3 5363.5 5405.3 5464.5 5485.2 5496.5 5540.4 5554.4 5559.3 5569.7 5214.5 5410.8 5451.8 5466.8 5536.6 01:07:09 INFO - PROCESS | 2079 | 01:07:09 INFO - PROCESS | 2079 | [#5] yui.html Cycles:180 Average:19106.10 Median:4444.20 stddev:27310.49 (614.5%) stddev-sans-first:27352.03 01:07:09 INFO - PROCESS | 2079 | Values: 673.4 778.9 792.8 805.9 815.2 14814.9 16228.6 16241.8 16311.4 16351.2 13945.2 14668.2 14701.5 14822.3 14873.3 797.6 803.7 804.6 804.8 805.1 665.7 674.8 800.7 810.3 820.0 861.0 862.3 863.3 863.4 864.8 858.8 860.1 860.2 860.3 860.3 508.1 517.3 615.4 621.6 628.8 13435.3 13479.4 13506.7 13553.4 13565.9 13127.7 13140.8 13208.9 13436.9 14474.2 12346.1 12384.7 12595.7 13012.4 13432.7 4248.1 4317.6 4353.3 4381.3 4445.9 73183.0 73186.3 74180.6 75321.2 75384.0 10365.6 10422.9 10431.3 10572.8 10880.9 18357.0 18367.4 18371.7 18389.6 18405.5 7555.3 7735.2 7774.4 7941.6 7968.0 4258.4 4293.1 4386.5 4439.0 4442.5 3379.6 3534.0 3540.2 3540.4 3541.8 598.4 614.5 624.2 626.2 633.6 479.9 491.7 492.7 596.5 597.4 8387.5 8562.3 8584.5 8669.2 8888.5 571.7 576.5 589.1 590.5 632.7 4122.9 4146.5 4172.8 4305.8 4483.9 71526.6 73540.0 73902.6 74197.0 74307.0 101528.4 106871.5 108197.5 111849.0 113113.0 69759.0 92274.5 93538.5 94427.5 94770.1 8159.0 8411.5 8940.7 9020.9 9152.2 47845.5 48422.8 48621.8 49073.5 49547.8 52373.2 63506.7 65900.3 66830.7 68964.3 10674.5 10771.2 11163.4 11536.2 11891.5 13015.9 13046.4 13576.9 13579.3 13627.1 12450.6 12681.0 12708.2 12708.7 12985.9 12246.4 12307.3 12543.3 12604.2 12704.2 12232.2 12430.2 13016.5 13103.0 13334.6 9575.7 9995.5 10284.3 10645.9 10826.8 10078.8 10168.6 10512.6 10739.8 11003.8 01:07:09 INFO - PROCESS | 2079 | -------- Summary: end -------- 01:07:09 INFO - PROCESS | 2079 | 01:07:10 INFO - TEST-INFO | 2079: exit 0 01:07:10 INFO - TEST-OK | dromaeo_css | took 1117163ms 01:07:10 INFO - TEST-START | kraken 01:07:10 INFO - operating with platform_type : linux_ 01:07:10 INFO - Initialising browser for kraken test... 01:07:10 INFO - TEST-INFO | started process 2387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpak4crG/profile http://localhost:49100/getInfo.html) 01:07:14 INFO - PROCESS | 2387 | __metrics Screen width/height:1600/1200 01:07:14 INFO - PROCESS | 2387 | colorDepth:24 01:07:14 INFO - PROCESS | 2387 | Browser inner width/height: 1024/697 01:07:14 INFO - PROCESS | 2387 | __metrics 01:07:15 INFO - PROCESS | 2387 | 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" 01:07:15 INFO - PROCESS | 2387 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:07:15 INFO - PROCESS | 2387 | console.error: PushService: 01:07:15 INFO - PROCESS | 2387 | stateChangeProcessEnqueue: Error transitioning state 01:07:15 INFO - PROCESS | 2387 | UnknownError 01:07:16 INFO - TEST-INFO | 2387: exit 0 01:07:16 INFO - Browser initialized. 01:07:16 INFO - Running cycle 1/1 for kraken test... 01:07:16 INFO - TEST-INFO | started process 2559 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpak4crG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:07:28 INFO - PROCESS | 2559 | RSS: Main: 173424640 01:07:28 INFO - PROCESS | 2559 | 01:07:31 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:49100/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49100/tests/kraken/driver.html?testName=audio-beat-detection) 01:07:31 INFO - PROCESS | 2559 | RSS: Main: 232742912 01:07:31 INFO - PROCESS | 2559 | 01:07:34 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:49100/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49100/tests/kraken/driver.html?testName=audio-dft) 01:07:35 INFO - PROCESS | 2559 | RSS: Main: 218030080 01:07:35 INFO - PROCESS | 2559 | 01:07:38 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:49100/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49100/tests/kraken/driver.html?testName=audio-fft) 01:07:38 INFO - PROCESS | 2559 | RSS: Main: 299773952 01:07:38 INFO - PROCESS | 2559 | 01:07:41 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:49100/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49100/tests/kraken/driver.html?testName=audio-oscillator) 01:07:41 INFO - PROCESS | 2559 | RSS: Main: 210272256 01:07:41 INFO - PROCESS | 2559 | 01:07:43 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:49100/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49100/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:07:44 INFO - PROCESS | 2559 | RSS: Main: 213516288 01:07:44 INFO - PROCESS | 2559 | 01:07:47 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:49100/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49100/tests/kraken/driver.html?testName=imaging-darkroom) 01:07:48 INFO - PROCESS | 2559 | RSS: Main: 249827328 01:07:48 INFO - PROCESS | 2559 | 01:07:51 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:49100/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49100/tests/kraken/driver.html?testName=imaging-desaturate) 01:07:51 INFO - PROCESS | 2559 | RSS: Main: 248442880 01:07:51 INFO - PROCESS | 2559 | 01:07:54 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:49100/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49100/tests/kraken/driver.html?testName=json-parse-financial) 01:07:55 INFO - PROCESS | 2559 | RSS: Main: 248725504 01:07:55 INFO - PROCESS | 2559 | 01:07:56 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:49100/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49100/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:07:57 INFO - PROCESS | 2559 | RSS: Main: 210649088 01:07:57 INFO - PROCESS | 2559 | 01:07:59 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:49100/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49100/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:07:59 INFO - PROCESS | 2559 | RSS: Main: 218439680 01:07:59 INFO - PROCESS | 2559 | 01:08:01 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:49100/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49100/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:08:02 INFO - PROCESS | 2559 | RSS: Main: 227590144 01:08:02 INFO - PROCESS | 2559 | 01:08:05 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:49100/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:08:05 INFO - PROCESS | 2559 | RSS: Main: 235868160 01:08:05 INFO - PROCESS | 2559 | 01:08:08 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:49100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:08:09 INFO - PROCESS | 2559 | RSS: Main: 233390080 01:08:09 INFO - PROCESS | 2559 | 01:08:10 INFO - PROCESS | 2559 | Cycle 1(1): loaded http://localhost:49100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49100/tests/kraken/driver.html?testName=ai-astar) 01:08:11 INFO - PROCESS | 2559 | RSS: Main: 284487680 01:08:11 INFO - PROCESS | 2559 | 01:08:11 INFO - PROCESS | 2559 | __start_tp_report 01:08:11 INFO - PROCESS | 2559 | _x_x_mozilla_page_load 01:08:11 INFO - PROCESS | 2559 | _x_x_mozilla_page_load_details 01:08:11 INFO - PROCESS | 2559 | |i|pagename|runs| 01:08:11 INFO - PROCESS | 2559 | |0;ai-astar;113;112;111;114;112;111;111;111;111;112 01:08:11 INFO - PROCESS | 2559 | |1;audio-beat-detection;151;128;124;161;122;122;121;122;159;127 01:08:11 INFO - PROCESS | 2559 | |2;audio-dft;160;163;162;161;161;161;160;161;160;162 01:08:11 INFO - PROCESS | 2559 | |3;audio-fft;74;75;76;114;75;75;75;75;111;76 01:08:11 INFO - PROCESS | 2559 | |4;audio-oscillator;84;90;118;83;84;84;101;83;82;119 01:08:11 INFO - PROCESS | 2559 | |5;imaging-gaussian-blur;118;118;117;117;117;117;118;117;117;118 01:08:11 INFO - PROCESS | 2559 | |6;imaging-darkroom;146;146;145;146;146;146;146;145;145;145 01:08:11 INFO - PROCESS | 2559 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 01:08:11 INFO - PROCESS | 2559 | |8;json-parse-financial;53;52;50;54;52;53;54;53;52;53 01:08:11 INFO - PROCESS | 2559 | |9;json-stringify-tinderbox;60;61;62;61;62;61;60;60;60;62 01:08:11 INFO - PROCESS | 2559 | |10;stanford-crypto-aes;80;80;80;80;79;79;89;80;83;80 01:08:11 INFO - PROCESS | 2559 | |11;stanford-crypto-ccm;131;130;135;143;135;138;140;132;170;130 01:08:11 INFO - PROCESS | 2559 | |12;stanford-crypto-pbkdf2;173;172;166;171;168;173;170;170;172;169 01:08:11 INFO - PROCESS | 2559 | |13;stanford-crypto-sha256-iterative;67;66;68;67;67;67;68;66;66;66 01:08:11 INFO - PROCESS | 2559 | __end_tp_report 01:08:11 INFO - PROCESS | 2559 | __start_cc_report 01:08:11 INFO - PROCESS | 2559 | _x_x_mozilla_cycle_collect,1656 01:08:11 INFO - PROCESS | 2559 | __end_cc_report 01:08:11 INFO - PROCESS | 2559 | __startTimestamp1475741291222__endTimestamp 01:08:11 INFO - PROCESS | 2559 | 01:08:11 INFO - PROCESS | 2559 | ------- Summary: start ------- 01:08:11 INFO - PROCESS | 2559 | Number of tests: 14 01:08:11 INFO - PROCESS | 2559 | 01:08:11 INFO - PROCESS | 2559 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:1.03 (0.9%) stddev-sans-first:1.00 01:08:11 INFO - PROCESS | 2559 | Values: 113.0 112.0 111.0 114.0 112.0 111.0 111.0 111.0 111.0 112.0 01:08:11 INFO - PROCESS | 2559 | 01:08:11 INFO - PROCESS | 2559 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:127.50 stddev:16.43 (12.9%) stddev-sans-first:16.18 01:08:11 INFO - PROCESS | 2559 | Values: 151.0 128.0 124.0 161.0 122.0 122.0 121.0 122.0 159.0 127.0 01:08:11 INFO - PROCESS | 2559 | 01:08:11 INFO - PROCESS | 2559 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 01:08:11 INFO - PROCESS | 2559 | Values: 160.0 163.0 162.0 161.0 161.0 161.0 160.0 161.0 160.0 162.0 01:08:11 INFO - PROCESS | 2559 | 01:08:11 INFO - PROCESS | 2559 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:15.78 (21.0%) stddev-sans-first:16.43 01:08:11 INFO - PROCESS | 2559 | Values: 74.0 75.0 76.0 114.0 75.0 75.0 75.0 75.0 111.0 76.0 01:08:11 INFO - PROCESS | 2559 | 01:08:11 INFO - PROCESS | 2559 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:83.50 stddev:14.67 (17.6%) stddev-sans-first:15.21 01:08:11 INFO - PROCESS | 2559 | Values: 84.0 90.0 118.0 83.0 84.0 84.0 101.0 83.0 82.0 119.0 01:08:11 INFO - PROCESS | 2559 | 01:08:11 INFO - PROCESS | 2559 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 01:08:11 INFO - PROCESS | 2559 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 01:08:11 INFO - PROCESS | 2559 | 01:08:11 INFO - PROCESS | 2559 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 01:08:11 INFO - PROCESS | 2559 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 01:08:11 INFO - PROCESS | 2559 | 01:08:11 INFO - PROCESS | 2559 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:08:11 INFO - PROCESS | 2559 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 01:08:11 INFO - PROCESS | 2559 | 01:08:11 INFO - PROCESS | 2559 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:1.17 (2.2%) stddev-sans-first:1.24 01:08:11 INFO - PROCESS | 2559 | Values: 53.0 52.0 50.0 54.0 52.0 53.0 54.0 53.0 52.0 53.0 01:08:11 INFO - PROCESS | 2559 | 01:08:11 INFO - PROCESS | 2559 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.88 (1.4%) stddev-sans-first:0.87 01:08:11 INFO - PROCESS | 2559 | Values: 60.0 61.0 62.0 61.0 62.0 61.0 60.0 60.0 60.0 62.0 01:08:11 INFO - PROCESS | 2559 | 01:08:11 INFO - PROCESS | 2559 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.00 stddev:3.02 (3.8%) stddev-sans-first:3.18 01:08:11 INFO - PROCESS | 2559 | Values: 80.0 80.0 80.0 80.0 79.0 79.0 89.0 80.0 83.0 80.0 01:08:11 INFO - PROCESS | 2559 | 01:08:11 INFO - PROCESS | 2559 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:136.50 stddev:11.94 (8.7%) stddev-sans-first:12.36 01:08:11 INFO - PROCESS | 2559 | Values: 131.0 130.0 135.0 143.0 135.0 138.0 140.0 132.0 170.0 130.0 01:08:11 INFO - PROCESS | 2559 | 01:08:11 INFO - PROCESS | 2559 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.50 stddev:2.27 (1.3%) stddev-sans-first:2.20 01:08:11 INFO - PROCESS | 2559 | Values: 173.0 172.0 166.0 171.0 168.0 173.0 170.0 170.0 172.0 169.0 01:08:11 INFO - PROCESS | 2559 | 01:08:11 INFO - PROCESS | 2559 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 01:08:11 INFO - PROCESS | 2559 | Values: 67.0 66.0 68.0 67.0 67.0 67.0 68.0 66.0 66.0 66.0 01:08:11 INFO - PROCESS | 2559 | -------- Summary: end -------- 01:08:11 INFO - PROCESS | 2559 | 01:08:12 INFO - TEST-INFO | 2559: exit 0 01:08:12 INFO - TEST-OK | kraken | took 62445ms 01:08:12 INFO - SUITE-END | took 1179s 01:08:12 INFO - Completed test suite (00:19:39) 01:08:12 INFO - javascript benchmark 01:08:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2975.598294230279, 3010.894618688345, 3011.7138871807183, 3044.2389402649337, 3057.908262752117, 5037.093323201822, 5122.92315615266, 5144.948550514494, 5224.503672151149, 5239.240310155025, 5112.8977420451565, 5184.766685499152, 5212.582993360532, 5252.842414727555, 5268.525832675058, 4676.205045142334, 4694.2723877799, 4711.787969541362, 4751.928721069186, 4763.404574428197, 4817.51824817519, 4859.781309841048, 4866.440359358684, 4889.804407823701, 4906.582940450066, 4636.049609830011, 4670.0, 4791.976040119812, 4851.539103785152, 4873.31773551703, 4619.584237418615, 4660.650451216173, 4694.835680751192, 4711.740854253015, 4718.976405117953, 4647.86056418308, 4664.510226426244, 4671.112488627184, 4714.104320179155, 4769.117713223065, 5174.6636468629795, 5193.376794784613, 5195.480451954812, 5201.037808005531, 5267.394249661262, 5343.545798607123, 5401.864953376158, 5449.427810079924, 5486.396496385394, 5528.364238112628, 5534.972325138388, 5546.750396232179, 5561.499465048165, 5566.944330556683, 5592.496675299242, 5159.922601160985, 5180.507851754077, 5184.585233181337, 5204.947950520522, 5266.289050978107, 5417.8103766367985, 5484.588655850827, 5497.230387745639, 5574.024545704486, 5574.136008918543, 5351.357837059578, 5431.8098866539485, 5436.864078398072, 5516.696581687966, 5517.0, 5508.834734957958, 5531.502164805187, 5532.640378375393, 5579.944200558024, 5600.159976003632, 5456.0, 5485.6434331768305, 5503.284573005483, 5505.862353441196, 5509.559235261169, 5314.521693047567, 5341.305630268041, 5372.5970552207955, 5375.892482150335, 5574.996500629844, 4222.345536441856, 4223.070924396628, 4223.577642235752, 4224.957750422456, 4246.617804397619, 3837.213371258885, 3882.9611703883165, 3895.8636447724193, 3909.2181563687377, 3916.7845768483007, 5240.737963101829, 5243.790248390098, 5244.134717771525, 5247.7113758743635, 5303.655262408009, 5563.638363506359, 5570.053090974544, 5572.108462645957, 5573.996680597531, 5637.830865074055, 5065.468125846806, 5106.234064890296, 5163.277141200235, 5212.55693266069, 5234.633575649744, 4841.0, 4845.345878306454, 4849.58778503824, 4877.292792545132, 4899.363082799213, 5688.431156884279, 5756.251687280543, 5763.85590360236, 5767.04843700793, 5825.533957283492, 5347.144456886879, 5401.513863752281, 5478.123500240102, 5550.47270509301, 5561.165825126263, 5726.0838265877255, 5785.768569257182, 5788.21859049023, 5850.444207800252, 5865.032269675627, 5435.184722291688, 5440.211169380338, 5441.591880609049, 5442.12925931849, 5446.1558458439, 5354.303940487712, 5405.405405405481, 5567.137093750475, 5583.972080139736, 5643.915341269966, 5356.839294821161, 5399.136138218023, 5422.376426710979, 5447.727613619382, 5513.007658621486, 5332.413434522122, 5373.247745315737, 5382.569394448356, 5388.757505912322, 5431.972840135774, 5158.845234642967, 5249.501297376743, 5290.206469029523, 5304.177852432879, 5372.892542149057, 5279.9472005280995, 5367.329083864517, 5421.159720243369, 5427.158790387496, 5521.723913804374, 5319.601029922848, 5321.521063104339, 5325.627206095536, 5326.6537675050995, 5330.360356757214], "value": 5105.45105798977, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.3407247592792, 585.096026638843, 593.3117583603022, 595.4492094812299, 601.5999360425318, 30750.231244218907, 31526.84236578817, 42143.36784948228, 43340.0, 43343.783281083626, 44047.11905761883, 44496.33255501162, 44529.777351113196, 44533.0, 44577.777111114396, 8849.424787388814, 9000.59497322622, 9002.504862232574, 9007.189352958232, 9009.234215091725, 7934.880976785324, 8131.268185863271, 8179.836403271931, 8734.432261902955, 10435.843462348072, 10567.630132945349, 10976.176786741027, 10977.792442831322, 10978.0, 10978.615748448807, 10760.73098172548, 10823.783524329468, 10842.241043126984, 10844.403557804317, 10845.51195196214, 7897.526148431112, 8122.147174546647, 10255.179585633132, 10643.0, 10713.625023124232, 38468.615313846785, 41483.377749333784, 41518.792406038076, 41591.168176636296, 41607.0, 3111.6266048074376, 3112.439760843047, 3122.4847900096456, 3136.357046805422, 3167.556542084087, 31232.21919452009, 31659.84170079135, 31936.0, 31981.200469988435, 32847.0, 3931.194105208454, 3984.9601503984877, 3997.6402123808707, 4088.8364465421346, 4187.450643262013, 323264.0, 324676.0, 325175.0, 326026.0, 326627.36686316656, 34343.484847727304, 35197.472037919455, 54982.45017549773, 55021.497850215455, 55308.0, 37126.0, 37306.62693373032, 37322.0, 37403.0, 37422.62577374246, 14863.33115009827, 15067.321970511353, 15186.088834669956, 15187.468438604596, 15204.771928421083, 10974.890251097388, 11217.15871309655, 11224.158188135922, 11229.606963756229, 11231.887681123084, 7937.126916039231, 8156.796080098045, 8323.875141872877, 8533.359998000175, 8609.22516973463, 3288.3423315337027, 3308.2887179256577, 3349.179451034512, 3366.646502117291, 3404.5233667286598, 985.8570507276548, 987.629638885418, 1006.174936552035, 1030.283952652914, 1076.2896488317829, 31234.375312493623, 31313.8434307827, 31319.686803132132, 31345.686543134732, 31611.84194079015, 1043.8642976413169, 1051.8264486359817, 1103.3600511703353, 1134.880837512066, 1144.3591588710349, 15581.610459738597, 16364.509064728078, 16380.83619163793, 16435.506934791738, 16823.747643785355, 460290.0, 464004.0, 464159.0, 464867.0, 465247.0, 48837.0, 49702.25446618304, 54907.45092549103, 57214.14178787322, 57919.0, 1219.4146809531296, 1283.9486420543074, 1319.6239071864472, 1320.3332317179763, 1321.3459337627935, 29866.35735034594, 32110.678893211705, 32249.193770154994, 32289.869854554978, 32322.83838580792, 48236.0, 48637.75681121572, 48762.5123748758, 48794.75602621964, 48803.26795098148, 413006.0, 422458.0, 431105.0, 432577.0, 660451.0, 42041.1591768169, 42253.0, 42275.0, 42288.0, 42778.0, 46267.305990410845, 46707.0, 46906.76546617245, 46959.29561056518, 47668.0, 38504.229915400974, 38596.6140338593, 38613.0, 40835.79582102071, 41077.1784564313, 39136.217275653755, 40137.1972560553, 40145.59854401535, 40294.79852600718, 40713.59286407098, 38350.61649383471, 39000.804995975974, 39512.60487395089, 39943.0, 40386.0, 33089.834550827094, 35353.82323088368, 35357.524973251624, 35388.64611353853, 35959.62827620384, 27076.1877143686, 27396.0, 27442.862785685942, 27685.861570692017, 27707.0], "value": 18708.011962270226, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.2280132731221, 389.8615991323082, 397.38802244543405, 398.43820213498964, 422.90696046869675, 17361.218745156468, 18801.81198188018, 18931.33740319089, 18940.81059189408, 18991.810081899177, 17591.472255832312, 18286.542836429096, 18425.170867310968, 18759.249630014816, 18931.62136757264, 5667.206591077253, 5834.27071616048, 5864.296284445851, 5908.231929849114, 5914.083317085837, 5610.07433773429, 5850.648961062328, 5852.151438041481, 5852.912206316909, 5853.209816674737, 5527.364353099405, 5761.0, 5808.04167312395, 5812.505936995361, 5819.709014549277, 5874.9412505874825, 5904.704764761745, 5913.586048976574, 5917.615355001911, 5919.319278282988, 5656.688882111483, 5867.0, 5900.43945825146, 5907.2911250650195, 5908.113782932552, 13949.721005579933, 14072.507462238773, 14089.85910140906, 14266.429342826275, 14343.0, 2240.708707867983, 2274.3518097342344, 2461.655368248447, 2524.861132637704, 2535.594304911205, 10168.542415591242, 10485.423301718403, 10528.263021588491, 10857.619983300625, 13270.14218009479, 1861.795202527721, 1900.1544312780818, 1908.3225454963565, 1923.913423895928, 1964.4401345616432, 74165.0, 76264.23735762626, 77251.61374193092, 77558.61220693917, 79086.0, 10236.744081398025, 10246.743831404274, 10506.684799456028, 10730.776149833078, 10990.505427255792, 15326.770098448533, 15344.693106138038, 15362.692746145014, 15375.923120384326, 15385.769213461806, 7823.9608801956765, 8123.390745694097, 8212.794680133044, 8281.875771863426, 8307.709230176915, 7705.499142555716, 7745.806354841061, 7781.26078022587, 8029.678812847537, 8085.919140808634, 4674.626029917598, 4691.929621055687, 4757.167495688241, 4791.425028996543, 4857.198562237191, 1875.1561797191318, 1925.7015162649811, 1970.5861769028666, 2015.2442833937273, 2035.2266138867433, 435.7407342631129, 438.6797637724415, 452.64241249413254, 814.8696208606594, 878.3587980773943, 11921.582744603897, 18032.188551515213, 19230.903845480683, 20036.69944950827, 20732.0, 941.2893265584577, 947.5830634520927, 961.4375590279625, 999.4702807512031, 1003.6336737091056, 10426.530806113744, 10968.341899486057, 10991.61529346485, 11070.114390848712, 11090.611828585961, 453561.0, 454281.0, 461545.0, 463268.0, 467547.0, 88637.55681221552, 90441.0, 90569.64145537822, 90905.54547227222, 90932.54533727422, 998.5606333213362, 1073.2111897755144, 1101.6970333158445, 1102.685734565645, 1104.4422566603814, 16459.91770041142, 17037.14814259307, 17364.652706946043, 17382.565435864206, 17445.47663570095, 40204.597954020086, 40903.1819363617, 41071.7946410266, 41411.0, 41563.7921810389, 54133.72933135309, 56147.719261405065, 56852.71573642105, 58087.70956145192, 58708.41291587029, 7876.921230787848, 8181.590920453835, 8462.619182136941, 8554.871676924726, 8593.785155370915, 8898.688545900863, 11356.94321528387, 11684.240524365889, 12475.5009799607, 12544.372781361079, 10875.836862446911, 10926.945365273123, 11184.720381990515, 11238.55045798159, 11536.36549989725, 10438.26932114775, 10563.419011954416, 10603.151747860307, 10865.402402867601, 10988.945055274673, 10489.527971241465, 10786.352818830896, 10806.0, 10972.561097556008, 10994.780104398027, 8128.105908349959, 8144.389170812095, 8244.340452763885, 8394.748157555283, 8553.871691924502, 9169.266458683423, 10500.842487362543, 10774.393983972566, 10782.838257426301, 10947.781044378908], "value": 8817.238797783315, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.4307190979787, 1472.32273154349, 1508.0574640849468, 1638.7705721199027, 1802.1079565615023, 7480.663370148342, 8271.586420678965, 8476.66093356265, 8489.811426400302, 8705.260052895495, 8491.193336633025, 8537.0, 8554.70058547951, 8562.957185214082, 8565.785855353619, 2275.9317220483413, 2291.324059402472, 2307.3193407944614, 2315.340128063502, 2317.2932255662017, 2225.94435139122, 2254.7068881045443, 2277.7152855893014, 2279.0541925101147, 2283.7716228377194, 2131.4990977120365, 2140.1867290429614, 2146.7209262795814, 2238.9776102238934, 2271.954560908781, 2168.566286742642, 2191.9561608767895, 2196.011794692387, 2200.427888748921, 2213.0262684418885, 2181.4873504726534, 2185.3553201805507, 2199.1533259694975, 2206.1616585697493, 2216.9778302217096, 8493.745187644381, 8531.402801803877, 8583.098774628637, 8600.956995214983, 8702.086280940473, 5153.3558305211845, 5362.35651721792, 5367.919481207785, 5372.0330340538685, 5375.462453754632, 3239.659835717263, 3282.786618869766, 3309.040378290317, 3317.092671713774, 3319.850606722703, 1111.1610733895857, 1117.3519358771894, 1123.3428444360059, 1127.9887201127965, 1150.9942450287695, 12075.93962030193, 12083.516659333616, 12150.513979440811, 12185.207961482476, 12188.268703877708, 4158.355454904495, 4374.58441448062, 4455.331700244924, 4535.206338890681, 4546.04533048057, 9500.334976551576, 9511.762205944768, 9523.428594284227, 9532.23742100644, 9536.427814331162, 5153.304303918998, 5159.380874295109, 5189.143791274473, 5193.792248310026, 5198.740062996835, 4310.870673879788, 4444.333349997526, 4696.718196908197, 4813.133635945564, 4861.829835955725, 3599.712023038203, 3644.1982763791925, 3710.703143748494, 3735.813209339522, 3753.530808648919, 1115.642994241835, 1117.7596816684452, 1130.1072152999202, 1130.4347826086957, 1136.693092864922, 792.0297635396593, 925.2829057480371, 926.5830376330678, 957.1003256938594, 961.0821665309612, 5932.940670593239, 5934.821955341346, 6020.217371741734, 6054.424829641177, 6380.170577824853, 901.9143181397887, 904.452806052342, 934.9252059835197, 948.3977674176809, 964.6575465709572, 3794.317022935898, 3888.941665875014, 4028.395740638869, 4106.958930410718, 4159.480064991876, 10688.51901664427, 10967.561297548169, 11125.276857004268, 11128.944355278334, 11169.664910052712, 10846.18653600983, 10950.835737463944, 11048.447577621087, 11052.668419947415, 11063.0, 8054.919450805534, 8120.228578285053, 8151.30713889326, 8232.094469608339, 8248.587570621445, 5782.710864456676, 5783.277090363705, 5861.677607731615, 5876.324222714443, 5970.910436343545, 9721.270904682036, 9745.26910481731, 9811.705648830546, 9843.753906152404, 10078.848817267894, 10142.898571014195, 10187.490625468845, 10240.897591023995, 10307.072363487323, 10334.224933129895, 6601.108850305147, 6980.825479362853, 7316.304951029643, 7350.595717235603, 7498.662560184914, 8584.785380365542, 8725.0, 8727.476351418934, 8737.519436431057, 8742.082081381617, 7578.696852125853, 7633.389328853789, 7790.065192176975, 7894.921050789419, 7939.0, 7187.209406965334, 7295.7081716732855, 7313.122425308997, 7378.188399275968, 7383.372413344926, 6506.25178104524, 6628.403443690091, 6629.105070815378, 6631.966840165768, 6648.634325112165, 4953.529414705597, 5056.115179843586, 5068.771905264198, 5168.043911876315, 5213.400458947118, 4881.414230292387, 4909.901801963869, 4939.851804445872, 5056.115179843586, 5059.898802023865], "value": 4515.187991808558, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.1275408605064, 336.1277484926615, 342.19925374623375, 343.1592598134569, 345.04938893348833, 5079.441261461246, 5213.644452442364, 5276.868078298045, 5327.813526526573, 5333.519983201511, 5100.540951314381, 5215.843524694255, 5220.034293655676, 5245.947540524594, 5251.264822924793, 4181.958180418187, 4192.454980852485, 4195.4545909031785, 4196.412502249687, 4212.241796476641, 4099.836006559734, 4151.169766046788, 4163.354680024601, 4200.873973780776, 4211.7472951623, 4153.8338466461455, 4154.169166166764, 4165.146145040275, 4173.269677806372, 4173.791310434482, 4065.939010914809, 4129.0, 4132.214879172948, 4139.586041395852, 4145.398917156996, 3685.68671662909, 3690.630936906288, 3695.4087346024507, 3696.131409118855, 3725.2549490102087, 4902.166631672624, 5053.823116190915, 5063.468335824722, 5078.593712503028, 5097.5667068299235, 4714.151452738506, 4727.409073865767, 4744.7627618618935, 4747.620190384761, 4755.881102972418, 5462.562994960394, 5465.262189604392, 5470.8937059232085, 5471.616986810925, 5482.780688772445, 3789.4694742736037, 3978.7214894957365, 3999.9400458649156, 4001.7198796084285, 4009.4787677601726, 5677.914831277493, 5688.203651488795, 5705.6576605404225, 5731.541476681897, 5732.627379220337, 4076.5923407658997, 4077.4087757275624, 4090.4886889138857, 4098.303288440972, 4100.384942258625, 3914.1584559319313, 4090.775007374623, 4122.154958233555, 4126.319157339066, 4151.958480415217, 4665.533446655375, 4678.3216433616935, 4685.835995740201, 4690.64820138491, 4708.858734237979, 5513.448655134454, 5514.476124768141, 5516.172574113915, 5524.447555244524, 5529.861753456195, 1329.860364661716, 1349.8447678517095, 1403.4596680277962, 1413.1591702936737, 1415.1933397963062, 879.9208071273616, 915.4781774388534, 923.4044041593135, 924.8289066522715, 930.4882314726873, 4543.750468621156, 4565.931511027337, 4606.286025666027, 4633.212353899845, 4657.301404789241, 4786.976065119652, 4828.420589529209, 4855.36880205571, 4862.756862156949, 4878.219484882402, 4446.488653804854, 4596.35651008859, 4624.468186158568, 4631.328457373662, 4637.333533218413, 2568.345072006664, 2594.818362714592, 2626.9772275347873, 2635.7891368690457, 2641.841489510597, 4995.525425084611, 5004.599632029429, 5006.599472042228, 5016.097102521581, 5034.018366418513, 4675.859724208279, 4939.2838038484215, 4964.90070198594, 4978.701277923336, 5012.924806127911, 5013.596193065874, 5023.949760502348, 5044.218146187347, 5068.290439338495, 5090.872728181825, 4812.759362031955, 4824.34871292371, 4862.465128835896, 4867.513248675245, 4875.390576177978, 4752.485139117783, 4768.260919557474, 4839.419269687519, 4847.781849816696, 5242.554382877498, 5815.505682017076, 5825.50483208932, 5829.47534721877, 5847.7368518417625, 5851.707414629166, 4106.240345535966, 4109.9589004109575, 4125.463689720317, 4135.29699951015, 4136.131412403309, 5445.754941027584, 5643.1535269709875, 5711.228984087095, 5711.714864155531, 5715.657060576379, 5533.723313834212, 5535.557155427637, 5540.501354878081, 5546.7781288748, 5571.573482308432, 5544.283301182472, 5561.916571251515, 5562.721863906708, 5571.637843540157, 5588.552915766648, 5220.269162317354, 5363.498220498267, 5405.324334458192, 5464.535514481155, 5485.204645326326, 5496.477834605706, 5540.418256083053, 5554.389017208023, 5559.332880054258, 5569.721513924206, 5214.530692237717, 5410.836670115787, 5451.754671039734, 5466.753996070107, 5536.584756143225], "value": 4070.1691523928175, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.3535805626598, 778.8714862047763, 792.805762588166, 805.9314958228554, 815.1725998111914, 14814.925925370371, 16228.594285142877, 16241.756373654405, 16311.429099981504, 16351.182440877968, 13945.163290202596, 14668.193249371281, 14701.485448009322, 14822.258887055657, 14873.256337183151, 797.5852556670513, 803.6664784114586, 804.6258489802241, 804.7666176808718, 805.1304591041691, 665.6605131383005, 674.8447856992894, 800.7437619961614, 810.307187354812, 819.983600327993, 860.9526476043815, 862.2886118951858, 863.313665635821, 863.4128792421151, 864.7794812322849, 858.8153546987428, 860.1312674199073, 860.1785295043281, 860.2601762484289, 860.3332417376521, 508.1412413021981, 517.3223077768135, 615.4153554123556, 621.6487684458267, 628.8427893026743, 13435.32823358838, 13479.393427295796, 13506.662333441742, 13553.39009744554, 13565.932170339183, 13127.737445251138, 13140.802887956688, 13208.86791132086, 13436.865631343659, 14474.203918784462, 12346.122742384754, 12384.690382740413, 12595.748085038247, 13012.414441350162, 13432.664183395396, 4248.086661367821, 4317.568243175689, 4353.325234588644, 4381.255186618282, 4445.933311000337, 73183.0, 73186.26813731901, 74180.62909685471, 75321.24678753197, 75384.0, 10365.585376585002, 10422.947885260524, 10431.321964072462, 10572.841407378895, 10880.891191087987, 18357.0, 18367.35714249995, 18371.72442413365, 18389.63220735578, 18405.5398615033, 7555.282248186413, 7735.22647735222, 7774.416918731118, 7941.6029198539845, 7967.960160199162, 4258.403823464718, 4293.104473470368, 4386.473623165177, 4439.045605194899, 4442.4669039715445, 3379.645137260552, 3534.0281422608987, 3540.238848647553, 3540.398132317512, 3541.752077354612, 598.35676647604, 614.50839328537, 624.2228425610144, 626.2453743239386, 633.5628416392674, 479.85844175968174, 491.68532139430795, 492.6817881567639, 596.5496050481859, 597.3501903370403, 8387.538685372363, 8562.272206862486, 8584.484930904166, 8669.176428239307, 8888.511131887679, 571.665575638248, 576.4869266352949, 589.0608630334665, 590.5246276747259, 632.7342516143231, 4122.896927576835, 4146.543636986331, 4172.77049762266, 4305.784710764449, 4483.932741008887, 71526.64236678783, 73540.0, 73902.63048684722, 74197.0, 74307.0, 101528.41593712269, 106871.46564267285, 108197.45901270601, 111849.0, 113113.0, 69759.0, 92274.53862730644, 93538.5323073394, 94427.52786236025, 94770.0522994775, 8159.0, 8411.537365444714, 8940.68707595231, 9020.909790902007, 9152.202406958848, 47845.521544784104, 48422.75788621034, 48621.756891215315, 49073.5092649069, 49547.752261238464, 52373.21440178324, 63506.68246658737, 65900.34099658942, 66830.66584667045, 68964.31035689579, 10674.519646615765, 10771.192160588143, 11163.44182790841, 11536.192466527262, 11891.464884080064, 13015.934920325337, 13046.41291141882, 13576.93211533936, 13579.253141077335, 13627.114237574922, 12450.63043065244, 12681.0, 12708.173968692376, 12708.682282943, 12985.935070324587, 12246.448909798903, 12307.26156430617, 12543.3101179436, 12604.243745375306, 12704.237745735285, 12232.204906681038, 12430.192037517532, 13016.544420945222, 13102.978943237615, 13334.599962001155, 9575.664851730156, 9995.500224988577, 10284.2801003932, 10645.946770266099, 10826.837597435888, 10078.8488172676, 10168.644097456849, 10512.632057877938, 10739.785204295715, 11003.834942476029], "value": 7064.261475319242, "unit": "score"}], "name": "dromaeo_css", "value": 6915.109807344577, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 111.0, 114.0, 112.0, 111.0, 111.0, 111.0, 111.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 128.0, 124.0, 161.0, 122.0, 122.0, 121.0, 122.0, 159.0, 127.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 162.0, 161.0, 161.0, 161.0, 160.0, 161.0, 160.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 114.0, 75.0, 75.0, 75.0, 75.0, 111.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 90.0, 118.0, 83.0, 84.0, 84.0, 101.0, 83.0, 82.0, 119.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 50.0, 54.0, 52.0, 53.0, 54.0, 53.0, 52.0, 53.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 62.0, 61.0, 62.0, 61.0, 60.0, 60.0, 60.0, 62.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 80.0, 79.0, 79.0, 89.0, 80.0, 83.0, 80.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 130.0, 135.0, 143.0, 135.0, 138.0, 140.0, 132.0, 170.0, 130.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 166.0, 171.0, 168.0, 173.0, 170.0, 170.0, 172.0, 169.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 67.0, 67.0, 67.0, 68.0, 66.0, 66.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1510.2000000000003, "alertThreshold": 2.0}]} 01:08:12 INFO - Return code: 0 01:08:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:08:13 INFO - # TBPL SUCCESS # 01:08:13 INFO - Running post-action listener: _resource_record_post_action 01:08:13 INFO - [mozharness: 2016-10-06 08:08:13.011558Z] Finished run-tests step (success) 01:08:13 INFO - Running post-run listener: _resource_record_post_run 01:08:13 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399822848; Read time: 8; Write time: 297664 01:08:13 INFO - TinderboxPrint: CPU usage
13.1% 01:08:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 01:08:13 INFO - TinderboxPrint: I/O write bytes / time
399,822,848 / 297,664 01:08:13 INFO - TinderboxPrint: CPU idle
8,298.3 (86.9%) 01:08:13 INFO - TinderboxPrint: CPU user
1,200.7 (12.6%) 01:08:13 INFO - TinderboxPrint: Swap in / out
0 / 0 01:08:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110559232; Read time: 0; Write time: 91628 01:08:13 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288862208; Read time: 0; Write time: 206008 01:08:13 INFO - Running post-run listener: _upload_blobber_files 01:08:13 INFO - Blob upload gear active. 01:08:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:08:13 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 01:08:13 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'] 01:08:13 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 01:08:14 INFO - (blobuploader) - INFO - Open directory for files ... 01:08:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:08:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:08:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:08:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:08:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:08:14 INFO - (blobuploader) - INFO - Done attempting. 01:08:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:08:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:08:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:08:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:08:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:08:20 INFO - (blobuploader) - INFO - Done attempting. 01:08:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:08:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:08:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:08:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:08:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:08:20 INFO - (blobuploader) - INFO - Done attempting. 01:08:20 INFO - (blobuploader) - INFO - Iteration through files over. 01:08:20 INFO - Return code: 0 01:08:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:08:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:08:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d1115ecebe1e450d249833520dbfa4f3908b65b1543a4ddec3a2d586c5dd6b0fce0df0db9c2cc38db1c204b00fe37231aef3e6f9f552accb3a470be9a0df2d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd66834c1250ad1d008b18908bbd379c17022646a4a21c6499cdc68e11eec8820708e85400fc5a8cdc4f4a145e7f3397907d531ba924ade41828c58b7d090f09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c80012fff062053c7d87b37e792ab26f694f09ee31ae139354c441fe7c8e670c59e0fa6564343ae4ddcead4b4f83c2a70ef5cb4ea39302600121a11a03e8454"} 01:08:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:08:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:08:20 INFO - Contents: 01:08:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d1115ecebe1e450d249833520dbfa4f3908b65b1543a4ddec3a2d586c5dd6b0fce0df0db9c2cc38db1c204b00fe37231aef3e6f9f552accb3a470be9a0df2d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd66834c1250ad1d008b18908bbd379c17022646a4a21c6499cdc68e11eec8820708e85400fc5a8cdc4f4a145e7f3397907d531ba924ade41828c58b7d090f09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c80012fff062053c7d87b37e792ab26f694f09ee31ae139354c441fe7c8e670c59e0fa6564343ae4ddcead4b4f83c2a70ef5cb4ea39302600121a11a03e8454"} 01:08:20 INFO - Running post-run listener: copy_logs_to_upload_dir 01:08:20 INFO - Copying logs to upload dir... 01:08:20 INFO - mkdir: /builds/slave/test/build/upload/logs 01:08:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.463299 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-06 01:08:19.998383) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 01:08:20.002928) ========= 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=836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807 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/1d1115ecebe1e450d249833520dbfa4f3908b65b1543a4ddec3a2d586c5dd6b0fce0df0db9c2cc38db1c204b00fe37231aef3e6f9f552accb3a470be9a0df2d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd66834c1250ad1d008b18908bbd379c17022646a4a21c6499cdc68e11eec8820708e85400fc5a8cdc4f4a145e7f3397907d531ba924ade41828c58b7d090f09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c80012fff062053c7d87b37e792ab26f694f09ee31ae139354c441fe7c8e670c59e0fa6564343ae4ddcead4b4f83c2a70ef5cb4ea39302600121a11a03e8454"} build_url:https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011293 build_url: 'https://queue.taskcluster.net/v1/task/MN1fdF2DRvWTxztAMoaZug/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/1d1115ecebe1e450d249833520dbfa4f3908b65b1543a4ddec3a2d586c5dd6b0fce0df0db9c2cc38db1c204b00fe37231aef3e6f9f552accb3a470be9a0df2d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd66834c1250ad1d008b18908bbd379c17022646a4a21c6499cdc68e11eec8820708e85400fc5a8cdc4f4a145e7f3397907d531ba924ade41828c58b7d090f09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c80012fff062053c7d87b37e792ab26f694f09ee31ae139354c441fe7c8e670c59e0fa6564343ae4ddcead4b4f83c2a70ef5cb4ea39302600121a11a03e8454"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 01:08:20.036022) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 01:08:20.036621) ========= 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=836cfdc75598d54cb747368e000001a9-1475740056.908403-227403807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 01:08:20.119146) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 01:08:20.119509) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 01:08:20.119865) ========= ========= Total master_lag: 0.18 =========