builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1476322780.86 results: success (0) buildid: 20161012182923 builduid: cf7dec178ceb4d5197a187d0ef25d0ce revision: d68def1644c1849141ceaa31bc1b811becfbb8da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 18:39:40.861720) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 18:39:40.862178) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 18:39:40.862455) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 18:39:40.877135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:39:40.877439) ========= 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=db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-12 18:39:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-10-12 18:39:41 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130480 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:39:41.021803) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:39:41.022172) ========= 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=db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020106 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:39:41.074253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:39:41.074854) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d68def1644c1849141ceaa31bc1b811becfbb8da --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 d68def1644c1849141ceaa31bc1b811becfbb8da --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=db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-12 18:39:41,610 truncating revision to first 12 chars 2016-10-12 18:39:41,610 Setting DEBUG logging. 2016-10-12 18:39:41,610 attempt 1/10 2016-10-12 18:39:41,610 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d68def1644c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 18:39:42,066 unpacking tar archive at: fx-team-d68def1644c1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.877447 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 18:39:41.966726) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 18:39:41.967066) ========= script_repo_revision: d68def1644c1849141ceaa31bc1b811becfbb8da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 18:39:41.967470) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 18:39:41.967753) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 18:39:41.977279) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-10-12 18:39:41.977693) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:39:42 INFO - MultiFileLogger online at 20161012 18:39:42 in /builds/slave/test 18:39:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:39:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:39:42 INFO - {'append_to_log': False, 18:39:42 INFO - 'base_work_dir': '/builds/slave/test', 18:39:42 INFO - 'blob_upload_branch': 'Fx-Team', 18:39:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:39:42 INFO - 'branch': 'Fx-Team', 18:39:42 INFO - 'buildbot_json_path': 'buildprops.json', 18:39:42 INFO - 'config_files': ('talos/linux_config.py',), 18:39:42 INFO - 'default_actions': ('clobber', 18:39:42 INFO - 'read-buildbot-config', 18:39:42 INFO - 'download-and-extract', 18:39:42 INFO - 'populate-webroot', 18:39:42 INFO - 'create-virtualenv', 18:39:42 INFO - 'install', 18:39:42 INFO - 'run-tests'), 18:39:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:39:42 INFO - 'download_minidump_stackwalk': True, 18:39:42 INFO - 'download_symbols': 'ondemand', 18:39:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:39:42 INFO - 'tooltool.py': '/tools/tooltool.py', 18:39:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:39:42 INFO - '/tools/misc-python/virtualenv.py')}, 18:39:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:39:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:39:42 INFO - 'installer_path': 'installer.exe', 18:39:42 INFO - 'log_level': 'info', 18:39:42 INFO - 'log_name': 'talos', 18:39:42 INFO - 'log_to_console': True, 18:39:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:39:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:39:42 INFO - 'opt_config_files': (), 18:39:42 INFO - 'pip_index': False, 18:39:42 INFO - 'sps_profile': False, 18:39:42 INFO - 'sps_profile_interval': 0, 18:39:42 INFO - 'suite': 'dromaeojs-e10s', 18:39:42 INFO - 'system_bits': '32', 18:39:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:39:42 INFO - 'title': 'talos-linux64-ix-049', 18:39:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:39:42 INFO - 'use_talos_json': True, 18:39:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:39:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:39:42 INFO - 'work_dir': 'build'} 18:39:42 INFO - [mozharness: 2016-10-13 01:39:42.609980Z] Running clobber step. 18:39:42 INFO - Running pre-action listener: _resource_record_pre_action 18:39:42 INFO - Running main action method: clobber 18:39:42 INFO - rmtree: /builds/slave/test/build 18:39:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:39:43 INFO - Running post-action listener: _resource_record_post_action 18:39:43 INFO - [mozharness: 2016-10-13 01:39:43.084136Z] Finished clobber step (success) 18:39:43 INFO - [mozharness: 2016-10-13 01:39:43.084237Z] Running read-buildbot-config step. 18:39:43 INFO - Running pre-action listener: _resource_record_pre_action 18:39:43 INFO - Running main action method: read_buildbot_config 18:39:43 INFO - Using buildbot properties: 18:39:43 INFO - { 18:39:43 INFO - "project": "", 18:39:43 INFO - "product": "firefox", 18:39:43 INFO - "script_repo_revision": "production", 18:39:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:39:43 INFO - "repository": "", 18:39:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 18:39:43 INFO - "buildid": "20161012182923", 18:39:43 INFO - "stage_platform": "linux64-pgo", 18:39:43 INFO - "basedir": "/builds/slave/test", 18:39:43 INFO - "buildnumber": 1238, 18:39:43 INFO - "platform": "ubuntu64_hw", 18:39:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:39:43 INFO - "slavebuilddir": "test", 18:39:43 INFO - "branch": "fx-team", 18:39:43 INFO - "revision": "d68def1644c1849141ceaa31bc1b811becfbb8da", 18:39:43 INFO - "slavename": "talos-linux64-ix-049", 18:39:43 INFO - "builduid": "cf7dec178ceb4d5197a187d0ef25d0ce", 18:39:43 INFO - "repo_path": "integration/fx-team" 18:39:43 INFO - } 18:39:43 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:39:43 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 18:39:43 INFO - Running post-action listener: _resource_record_post_action 18:39:43 INFO - [mozharness: 2016-10-13 01:39:43.086628Z] Finished read-buildbot-config step (success) 18:39:43 INFO - [mozharness: 2016-10-13 01:39:43.086718Z] Running download-and-extract step. 18:39:43 INFO - Running pre-action listener: _resource_record_pre_action 18:39:43 INFO - Running main action method: download_and_extract 18:39:43 INFO - mkdir: /builds/slave/test/build/tests 18:39:43 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')]} 18:39:43 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:39:43 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/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 18:39:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/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 18:39:43 INFO - Downloaded 1361 bytes. 18:39:43 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:39:43 INFO - Using the following test package requirements: 18:39:43 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:39:43 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:39:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:39:43 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:39:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:39:43 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:39:43 INFO - u'jsshell-linux-x86_64.zip'], 18:39:43 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:39:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:39:43 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:39:43 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:39:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:39:43 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:39:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:39:43 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:39:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:39:43 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:39:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:39:43 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:39:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:39:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:39:43 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:39:43 INFO - Http code: 200 18:39:43 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 18:39:43 INFO - x-amz-cf-id: UHVodI7WBi8tz5UQSWwJXpiX4QUC_L7nIumRIFyy44z7CDY_zlcr0w== 18:39:43 INFO - x-amz-replication-status: COMPLETED 18:39:43 INFO - x-amz-version-id: PPLZvMJMo_Fy0WkEaLUPfXFRrxRvhFxW 18:39:43 INFO - Expected file size: 22117649 18:39:43 INFO - Obtained file size: 22117649 18:39:47 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 18:39:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:39:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:39:47 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:39:47 INFO - Http code: 200 18:39:47 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 18:39:47 INFO - x-amz-cf-id: zSB7fwhaRq-_y1SkZkxawA80wfjw3b-PBN44t1QFn-xuOcWWKnyq9w== 18:39:47 INFO - x-amz-replication-status: COMPLETED 18:39:47 INFO - x-amz-version-id: PPLZvMJMo_Fy0WkEaLUPfXFRrxRvhFxW 18:39:47 INFO - Expected file size: 22117649 18:39:47 INFO - Obtained file size: 22117649 18:39:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:39:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:39:52 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:39:52 INFO - Http code: 200 18:39:52 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 18:39:52 INFO - x-amz-cf-id: HfEGu1_Fk_X76-yWRnJ8IJl7Fh_O2wAEFLUvqD6GPaVEly63Xi5PwA== 18:39:52 INFO - x-amz-replication-status: COMPLETED 18:39:52 INFO - x-amz-version-id: qraT6K7K3tjQ3i_OnrbjB0M47MMZWnDw 18:39:52 INFO - Expected file size: 14409006 18:39:52 INFO - Obtained file size: 14409006 18:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:52 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:39:52 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/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 18:39:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/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 18:39:53 INFO - Downloaded 59805831 bytes. 18:39:53 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:39:53 INFO - mkdir: /builds/slave/test/properties 18:39:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:39:53 INFO - Writing to file /builds/slave/test/properties/build_url 18:39:53 INFO - Contents: 18:39:53 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:39:53 INFO - Running post-action listener: _resource_record_post_action 18:39:53 INFO - Running post-action listener: set_extra_try_arguments 18:39:53 INFO - [mozharness: 2016-10-13 01:39:53.631465Z] Finished download-and-extract step (success) 18:39:53 INFO - [mozharness: 2016-10-13 01:39:53.631693Z] Running populate-webroot step. 18:39:53 INFO - Running pre-action listener: _resource_record_pre_action 18:39:53 INFO - Running main action method: populate_webroot 18:39:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:39:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:39:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:39:53 INFO - '--tppagecycles', 18:39:53 INFO - '7'], 18:39:53 INFO - 'tests': ['tsvgm']}}, 18:39:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:39:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:39:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:39:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:39:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:39:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:39:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:39:53 INFO - 'talos_options': ['--disable-e10s'], 18:39:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:39:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:39:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:39:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:39:53 INFO - 'talos_options': ['--disable-e10s'], 18:39:53 INFO - 'tests': ['damp', 'tps']}, 18:39:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:39:53 INFO - 'tests': ['damp', 'tps']}, 18:39:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:39:53 INFO - 'tests': ['dromaeo_dom']}, 18:39:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:39:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:39:53 INFO - 'tests': ['basic_compositor_video']}, 18:39:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:39:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:39:53 INFO - 'tests': ['a11yr', 18:39:53 INFO - 'ts_paint', 18:39:53 INFO - 'tpaint', 18:39:53 INFO - 'sessionrestore', 18:39:53 INFO - 'sessionrestore_no_auto_restore', 18:39:53 INFO - 'tabpaint']}, 18:39:53 INFO - 'other-e10s': {'tests': ['a11yr', 18:39:53 INFO - 'ts_paint', 18:39:53 INFO - 'tpaint', 18:39:53 INFO - 'sessionrestore', 18:39:53 INFO - 'sessionrestore_no_auto_restore', 18:39:53 INFO - 'tabpaint']}, 18:39:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:39:53 INFO - 'ts_paint', 18:39:53 INFO - 'tpaint', 18:39:53 INFO - 'sessionrestore', 18:39:53 INFO - 'sessionrestore_no_auto_restore', 18:39:53 INFO - 'tabpaint']}, 18:39:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:39:53 INFO - 'ts_paint', 18:39:53 INFO - 'tpaint', 18:39:53 INFO - 'sessionrestore', 18:39:53 INFO - 'sessionrestore_no_auto_restore', 18:39:53 INFO - 'tabpaint']}, 18:39:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:39:53 INFO - 'tests': ['a11yr', 18:39:53 INFO - 'ts_paint', 18:39:53 INFO - 'tpaint', 18:39:53 INFO - 'sessionrestore', 18:39:53 INFO - 'sessionrestore_no_auto_restore', 18:39:53 INFO - 'tabpaint']}, 18:39:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:39:53 INFO - 'tests': ['a11yr', 18:39:53 INFO - 'ts_paint', 18:39:53 INFO - 'tpaint', 18:39:53 INFO - 'sessionrestore', 18:39:53 INFO - 'sessionrestore_no_auto_restore', 18:39:53 INFO - 'tabpaint']}, 18:39:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:39:53 INFO - 'tests': ['tsvgx', 18:39:53 INFO - 'tsvgr_opacity', 18:39:53 INFO - 'tart', 18:39:53 INFO - 'tscrollx', 18:39:53 INFO - 'cart']}, 18:39:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:39:53 INFO - 'tsvgr_opacity', 18:39:53 INFO - 'tart', 18:39:53 INFO - 'tscrollx', 18:39:53 INFO - 'cart']}, 18:39:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:39:53 INFO - 'talos_options': ['--disable-e10s'], 18:39:53 INFO - 'tests': ['tp5o']}, 18:39:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:39:53 INFO - 'tests': ['tp5o']}, 18:39:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:39:53 INFO - 'talos_options': ['--disable-e10s', 18:39:53 INFO - '--xperf_path', 18:39:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:39:53 INFO - 'tests': ['tp5n']}, 18:39:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:39:53 INFO - 'talos_options': ['--xperf_path', 18:39:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:39:53 INFO - 'tests': ['tp5n']}}, 18:39:53 INFO - 'talos.zip': {'path': '', 18:39:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:39:53 INFO - Running post-action listener: _resource_record_post_action 18:39:53 INFO - [mozharness: 2016-10-13 01:39:53.653720Z] Finished populate-webroot step (success) 18:39:53 INFO - [mozharness: 2016-10-13 01:39:53.653808Z] Running create-virtualenv step. 18:39:53 INFO - Running pre-action listener: _resource_record_pre_action 18:39:53 INFO - Running main action method: create_virtualenv 18:39:53 INFO - Creating virtualenv /builds/slave/test/build/venv 18:39:53 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 18:39:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:39:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:39:53 INFO - Using real prefix '/usr' 18:39:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:39:54 INFO - Installing distribute.............................................................................................................................................................................................done. 18:39:56 INFO - Installing pip.................done. 18:39:56 INFO - Return code: 0 18:39:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:39:56 INFO - Reading from file tmpfile_stdout 18:39:56 INFO - Output received: 18:39:56 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) 18:39:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:39:56 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')]} 18:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:56 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')]} 18:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:56 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 0x7fbd1affbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2239790>, '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 0x223a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223ab20>, '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': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', '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 18:39:56 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 18:39:56 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 18:39:56 INFO - Using env: {'DISPLAY': ':0', 18:39:56 INFO - 'HOME': '/home/cltbld', 18:39:56 INFO - 'LANG': 'en_US.UTF-8', 18:39:56 INFO - 'LANGUAGE': 'en_US:en', 18:39:56 INFO - 'LOGNAME': 'cltbld', 18:39:56 INFO - 'MAIL': '/var/mail/cltbld', 18:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:56 INFO - 'MOZ_NO_REMOTE': '1', 18:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:56 INFO - 'NO_EM_RESTART': '1', 18:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:56 INFO - 'PWD': '/builds/slave/test', 18:39:56 INFO - 'SHELL': '/bin/bash', 18:39:56 INFO - 'SHLVL': '1', 18:39:56 INFO - 'TERM': 'linux', 18:39:56 INFO - 'TMOUT': '86400', 18:39:56 INFO - 'USER': 'cltbld', 18:39:56 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', 18:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:56 INFO - '_': '/tools/buildbot/bin/python'} 18:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:56 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 18:39:56 INFO - Cleaning up... 18:39:56 INFO - Return code: 0 18:39:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:39:56 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')]} 18:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:56 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')]} 18:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:56 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 0x7fbd1affbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2239790>, '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 0x223a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223ab20>, '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': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', '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 18:39:56 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 18:39:56 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 18:39:56 INFO - Using env: {'DISPLAY': ':0', 18:39:56 INFO - 'HOME': '/home/cltbld', 18:39:56 INFO - 'LANG': 'en_US.UTF-8', 18:39:56 INFO - 'LANGUAGE': 'en_US:en', 18:39:56 INFO - 'LOGNAME': 'cltbld', 18:39:56 INFO - 'MAIL': '/var/mail/cltbld', 18:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:56 INFO - 'MOZ_NO_REMOTE': '1', 18:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:56 INFO - 'NO_EM_RESTART': '1', 18:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:56 INFO - 'PWD': '/builds/slave/test', 18:39:56 INFO - 'SHELL': '/bin/bash', 18:39:56 INFO - 'SHLVL': '1', 18:39:56 INFO - 'TERM': 'linux', 18:39:56 INFO - 'TMOUT': '86400', 18:39:56 INFO - 'USER': 'cltbld', 18:39:56 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', 18:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:56 INFO - '_': '/tools/buildbot/bin/python'} 18:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:56 INFO - Downloading/unpacking psutil>=3.1.1 18:39: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 18:39: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 18:39: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 18:39: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 18:39: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 18:39: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 18:39:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:39:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:39:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:39:58 INFO - Installing collected packages: psutil 18:39:58 INFO - Running setup.py install for psutil 18:39:58 INFO - building 'psutil._psutil_linux' extension 18:39: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 18:39:59 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 18:39:59 INFO - building 'psutil._psutil_posix' extension 18:39:59 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 18:39:59 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 18:39:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:39:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:39:59 INFO - Successfully installed psutil 18:39:59 INFO - Cleaning up... 18:39:59 INFO - Return code: 0 18:39:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:59 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 0x7fbd1affbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2239790>, '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 0x223a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223ab20>, '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': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', '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 18:39:59 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 18:39:59 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 18:39:59 INFO - Using env: {'DISPLAY': ':0', 18:39:59 INFO - 'HOME': '/home/cltbld', 18:39:59 INFO - 'LANG': 'en_US.UTF-8', 18:39:59 INFO - 'LANGUAGE': 'en_US:en', 18:39:59 INFO - 'LOGNAME': 'cltbld', 18:39:59 INFO - 'MAIL': '/var/mail/cltbld', 18:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:59 INFO - 'MOZ_NO_REMOTE': '1', 18:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:59 INFO - 'NO_EM_RESTART': '1', 18:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:59 INFO - 'PWD': '/builds/slave/test', 18:39:59 INFO - 'SHELL': '/bin/bash', 18:39:59 INFO - 'SHLVL': '1', 18:39:59 INFO - 'TERM': 'linux', 18:39:59 INFO - 'TMOUT': '86400', 18:39:59 INFO - 'USER': 'cltbld', 18:39:59 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', 18:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:59 INFO - '_': '/tools/buildbot/bin/python'} 18:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:39:59 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 18:39:59 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 18:39:59 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 18:39:59 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 18:39:59 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 18:39:59 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 18:40:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:40:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:40:01 INFO - Installing collected packages: mozsystemmonitor 18:40:01 INFO - Running setup.py install for mozsystemmonitor 18:40:01 INFO - Successfully installed mozsystemmonitor 18:40:01 INFO - Cleaning up... 18:40:01 INFO - Return code: 0 18:40:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:40:01 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')]} 18:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:01 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')]} 18:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:01 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 0x7fbd1affbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2239790>, '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 0x223a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223ab20>, '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': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', '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 18:40:01 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 18:40:01 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 18:40:01 INFO - Using env: {'DISPLAY': ':0', 18:40:01 INFO - 'HOME': '/home/cltbld', 18:40:01 INFO - 'LANG': 'en_US.UTF-8', 18:40:01 INFO - 'LANGUAGE': 'en_US:en', 18:40:01 INFO - 'LOGNAME': 'cltbld', 18:40:01 INFO - 'MAIL': '/var/mail/cltbld', 18:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:01 INFO - 'MOZ_NO_REMOTE': '1', 18:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:01 INFO - 'NO_EM_RESTART': '1', 18:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:01 INFO - 'PWD': '/builds/slave/test', 18:40:01 INFO - 'SHELL': '/bin/bash', 18:40:01 INFO - 'SHLVL': '1', 18:40:01 INFO - 'TERM': 'linux', 18:40:01 INFO - 'TMOUT': '86400', 18:40:01 INFO - 'USER': 'cltbld', 18:40:01 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', 18:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:01 INFO - '_': '/tools/buildbot/bin/python'} 18:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:02 INFO - Downloading/unpacking jsonschema==2.5.1 18:40:02 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 18:40:02 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 18:40:02 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 18:40:02 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 18:40:02 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 18:40:02 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 18:40:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:40:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:40: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 18:40: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 18:40: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 18:40: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 18:40: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 18:40: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 18:40:04 INFO - Downloading functools32-3.2.3-2.tar.gz 18:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:40:04 INFO - warning: no files found matching '*.txt' 18:40:04 INFO - no previously-included directories found matching 'build' 18:40:04 INFO - no previously-included directories found matching 'dist' 18:40:04 INFO - no previously-included directories found matching '.git*' 18:40:04 INFO - Installing collected packages: jsonschema, functools32 18:40:04 INFO - Running setup.py install for functools32 18:40:04 INFO - warning: no files found matching '*.txt' 18:40:04 INFO - no previously-included directories found matching 'build' 18:40:04 INFO - no previously-included directories found matching 'dist' 18:40:04 INFO - no previously-included directories found matching '.git*' 18:40:04 INFO - Successfully installed jsonschema functools32 18:40:04 INFO - Cleaning up... 18:40:04 INFO - Return code: 0 18:40:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:40:04 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')]} 18:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:04 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')]} 18:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:04 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 0x7fbd1affbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2239790>, '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 0x223a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223ab20>, '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': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', '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 18:40:04 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 18:40:04 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 18:40:04 INFO - Using env: {'DISPLAY': ':0', 18:40:04 INFO - 'HOME': '/home/cltbld', 18:40:04 INFO - 'LANG': 'en_US.UTF-8', 18:40:04 INFO - 'LANGUAGE': 'en_US:en', 18:40:04 INFO - 'LOGNAME': 'cltbld', 18:40:04 INFO - 'MAIL': '/var/mail/cltbld', 18:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:04 INFO - 'MOZ_NO_REMOTE': '1', 18:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:04 INFO - 'NO_EM_RESTART': '1', 18:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:04 INFO - 'PWD': '/builds/slave/test', 18:40:04 INFO - 'SHELL': '/bin/bash', 18:40:04 INFO - 'SHLVL': '1', 18:40:04 INFO - 'TERM': 'linux', 18:40:04 INFO - 'TMOUT': '86400', 18:40:04 INFO - 'USER': 'cltbld', 18:40:04 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', 18:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:04 INFO - '_': '/tools/buildbot/bin/python'} 18:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:40:04 INFO - Cleaning up... 18:40:04 INFO - Return code: 0 18:40:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:40:04 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')]} 18:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:04 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')]} 18:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:04 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 0x7fbd1affbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2239790>, '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 0x223a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223ab20>, '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': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', '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 18:40:04 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 18:40:04 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 18:40:04 INFO - Using env: {'DISPLAY': ':0', 18:40:04 INFO - 'HOME': '/home/cltbld', 18:40:04 INFO - 'LANG': 'en_US.UTF-8', 18:40:04 INFO - 'LANGUAGE': 'en_US:en', 18:40:04 INFO - 'LOGNAME': 'cltbld', 18:40:04 INFO - 'MAIL': '/var/mail/cltbld', 18:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:04 INFO - 'MOZ_NO_REMOTE': '1', 18:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:04 INFO - 'NO_EM_RESTART': '1', 18:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:04 INFO - 'PWD': '/builds/slave/test', 18:40:04 INFO - 'SHELL': '/bin/bash', 18:40:04 INFO - 'SHLVL': '1', 18:40:04 INFO - 'TERM': 'linux', 18:40:04 INFO - 'TMOUT': '86400', 18:40:04 INFO - 'USER': 'cltbld', 18:40:04 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', 18:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:04 INFO - '_': '/tools/buildbot/bin/python'} 18:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:04 INFO - Downloading/unpacking blobuploader==1.2.4 18:40:04 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 18:40:04 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 18:40:04 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 18:40:04 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 18:40:04 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 18:40:04 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 18:40:06 INFO - Downloading blobuploader-1.2.4.tar.gz 18:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:40:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:40: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 18:40: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 18:40: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 18:40: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 18:40: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 18:40: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 18:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:40:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:40:07 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 18:40:07 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 18:40:07 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 18:40:07 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 18:40:07 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 18:40:07 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 18:40:07 INFO - Downloading docopt-0.6.1.tar.gz 18:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:40:07 INFO - Installing collected packages: blobuploader, requests, docopt 18:40:07 INFO - Running setup.py install for blobuploader 18:40:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:40:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:40:07 INFO - Running setup.py install for requests 18:40:08 INFO - Running setup.py install for docopt 18:40:08 INFO - Successfully installed blobuploader requests docopt 18:40:08 INFO - Cleaning up... 18:40:08 INFO - Return code: 0 18:40:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:08 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')]} 18:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:08 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')]} 18:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:08 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 0x7fbd1affbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2239790>, '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 0x223a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223ab20>, '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': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', '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 18:40:08 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 18:40:08 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 18:40:08 INFO - Using env: {'DISPLAY': ':0', 18:40:08 INFO - 'HOME': '/home/cltbld', 18:40:08 INFO - 'LANG': 'en_US.UTF-8', 18:40:08 INFO - 'LANGUAGE': 'en_US:en', 18:40:08 INFO - 'LOGNAME': 'cltbld', 18:40:08 INFO - 'MAIL': '/var/mail/cltbld', 18:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:08 INFO - 'MOZ_NO_REMOTE': '1', 18:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:08 INFO - 'NO_EM_RESTART': '1', 18:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:08 INFO - 'PWD': '/builds/slave/test', 18:40:08 INFO - 'SHELL': '/bin/bash', 18:40:08 INFO - 'SHLVL': '1', 18:40:08 INFO - 'TERM': 'linux', 18:40:08 INFO - 'TMOUT': '86400', 18:40:08 INFO - 'USER': 'cltbld', 18:40:08 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', 18:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:08 INFO - '_': '/tools/buildbot/bin/python'} 18:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:40:08 INFO - Running setup.py (path:/tmp/pip-LzFpGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:40:08 INFO - Running setup.py (path:/tmp/pip-Ubb8ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:40:08 INFO - Running setup.py (path:/tmp/pip-AXaTLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:40:08 INFO - Running setup.py (path:/tmp/pip-lCphVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:40:08 INFO - Running setup.py (path:/tmp/pip-OlxffI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:40:08 INFO - Running setup.py (path:/tmp/pip-NsNFvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:40:08 INFO - Running setup.py (path:/tmp/pip-zyvEFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:40:08 INFO - Running setup.py (path:/tmp/pip-x6dyBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:40:08 INFO - Running setup.py (path:/tmp/pip-_GC21L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:40:09 INFO - Running setup.py (path:/tmp/pip-bZsB4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:40:09 INFO - Running setup.py (path:/tmp/pip-DC8Hzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:40:09 INFO - Running setup.py (path:/tmp/pip-GavXgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:40:09 INFO - Running setup.py (path:/tmp/pip-T5IjiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:40:09 INFO - Running setup.py (path:/tmp/pip-4PtQjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:09 INFO - Running setup.py (path:/tmp/pip-1V6fGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:40:09 INFO - Running setup.py (path:/tmp/pip-YKb5N1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:40:09 INFO - Running setup.py (path:/tmp/pip-cw3W2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:40:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:40:09 INFO - Running setup.py install for manifestparser 18:40:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:40:09 INFO - Running setup.py install for mozcrash 18:40:09 INFO - Running setup.py install for mozdebug 18:40:09 INFO - Running setup.py install for mozdevice 18:40:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:40:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:40:10 INFO - Running setup.py install for mozfile 18:40:10 INFO - Running setup.py install for mozhttpd 18:40:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:40:10 INFO - Running setup.py install for mozinfo 18:40:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:40:10 INFO - Running setup.py install for mozInstall 18:40:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:40:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:40:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:40:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:40:10 INFO - Running setup.py install for mozleak 18:40:10 INFO - Running setup.py install for mozlog 18:40:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:40:10 INFO - Running setup.py install for moznetwork 18:40:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:40:10 INFO - Running setup.py install for mozprocess 18:40:10 INFO - Running setup.py install for mozprofile 18:40:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:40:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:40:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:40:10 INFO - Running setup.py install for mozrunner 18:40:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:40:11 INFO - Running setup.py install for mozscreenshot 18:40:11 INFO - Running setup.py install for moztest 18:40:11 INFO - Running setup.py install for mozversion 18:40:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:40:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:40:11 INFO - Cleaning up... 18:40:11 INFO - Return code: 0 18:40:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:11 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')]} 18:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:11 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')]} 18:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:11 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 0x7fbd1affbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2239790>, '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 0x223a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223ab20>, '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': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', '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 18:40:11 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 18:40:11 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 18:40:11 INFO - Using env: {'DISPLAY': ':0', 18:40:11 INFO - 'HOME': '/home/cltbld', 18:40:11 INFO - 'LANG': 'en_US.UTF-8', 18:40:11 INFO - 'LANGUAGE': 'en_US:en', 18:40:11 INFO - 'LOGNAME': 'cltbld', 18:40:11 INFO - 'MAIL': '/var/mail/cltbld', 18:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:11 INFO - 'MOZ_NO_REMOTE': '1', 18:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:11 INFO - 'NO_EM_RESTART': '1', 18:40:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:11 INFO - 'PWD': '/builds/slave/test', 18:40:11 INFO - 'SHELL': '/bin/bash', 18:40:11 INFO - 'SHLVL': '1', 18:40:11 INFO - 'TERM': 'linux', 18:40:11 INFO - 'TMOUT': '86400', 18:40:11 INFO - 'USER': 'cltbld', 18:40:11 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', 18:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:11 INFO - '_': '/tools/buildbot/bin/python'} 18:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:40:11 INFO - Running setup.py (path:/tmp/pip-Eew2Nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:40: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)) 18:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:40:11 INFO - Running setup.py (path:/tmp/pip-zmYthQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:40: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)) 18:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:40:11 INFO - Running setup.py (path:/tmp/pip-Qat4EN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:40: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)) 18:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:40:11 INFO - Running setup.py (path:/tmp/pip-iWpKk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:40: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)) 18:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:40:11 INFO - Running setup.py (path:/tmp/pip-l3ccxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:40: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)) 18:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:40:11 INFO - Running setup.py (path:/tmp/pip-8PwidV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:40:12 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)) 18:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:40:12 INFO - Running setup.py (path:/tmp/pip-1bNZfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:40:12 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)) 18:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:40:12 INFO - Running setup.py (path:/tmp/pip-DQJHto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:40:12 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)) 18:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:40:12 INFO - Running setup.py (path:/tmp/pip-BCMgBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:40:12 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)) 18:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:40:12 INFO - Running setup.py (path:/tmp/pip-INhuYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:40:12 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)) 18:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:40:12 INFO - Running setup.py (path:/tmp/pip-KIw6rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:40:12 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)) 18:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:40:12 INFO - Running setup.py (path:/tmp/pip-k7DF9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:40:12 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)) 18:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:40:12 INFO - Running setup.py (path:/tmp/pip-1Kn0fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:40:12 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)) 18:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:40:12 INFO - Running setup.py (path:/tmp/pip-hJAO5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:40:12 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)) 18:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:12 INFO - Running setup.py (path:/tmp/pip-BgIKBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:40: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)) 18:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:40:12 INFO - Running setup.py (path:/tmp/pip-v4JdRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:40: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)) 18:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:40:12 INFO - Running setup.py (path:/tmp/pip-TIEPXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:40: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)) 18:40: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)) 18:40: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)) 18:40: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)) 18:40: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)) 18:40: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)) 18:40:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:40: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 18:40: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 18:40: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 18:40: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 18:40: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 18:40: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 18:40:14 INFO - Downloading blessings-1.6.tar.gz 18:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:40:14 INFO - Installing collected packages: blessings 18:40:14 INFO - Running setup.py install for blessings 18:40:14 INFO - Successfully installed blessings 18:40:14 INFO - Cleaning up... 18:40:15 INFO - Return code: 0 18:40:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:40:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:40:15 INFO - Reading from file tmpfile_stdout 18:40:15 INFO - Current package versions: 18:40:15 INFO - argparse == 1.2.1 18:40:15 INFO - blessings == 1.6 18:40:15 INFO - blobuploader == 1.2.4 18:40:15 INFO - docopt == 0.6.1 18:40:15 INFO - functools32 == 3.2.3-2 18:40:15 INFO - jsonschema == 2.5.1 18:40:15 INFO - manifestparser == 1.1 18:40:15 INFO - mozInstall == 1.12 18:40:15 INFO - mozcrash == 0.17 18:40:15 INFO - mozdebug == 0.1 18:40:15 INFO - mozdevice == 0.48 18:40:15 INFO - mozfile == 1.2 18:40:15 INFO - mozhttpd == 0.7 18:40:15 INFO - mozinfo == 0.9 18:40:15 INFO - mozleak == 0.1 18:40:15 INFO - mozlog == 3.4 18:40:15 INFO - moznetwork == 0.27 18:40:15 INFO - mozprocess == 0.23 18:40:15 INFO - mozprofile == 0.28 18:40:15 INFO - mozrunner == 6.12 18:40:15 INFO - mozscreenshot == 0.1 18:40:15 INFO - mozsystemmonitor == 0.3 18:40:15 INFO - moztest == 0.7 18:40:15 INFO - mozversion == 1.4 18:40:15 INFO - psutil == 3.1.1 18:40:15 INFO - requests == 1.2.3 18:40:15 INFO - wsgiref == 0.1.2 18:40:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:15 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 0x7fbd1affbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2239790>, '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 0x223a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223ab20>, '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': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', '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 18:40:15 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 18:40:15 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 18:40:15 INFO - Using env: {'DISPLAY': ':0', 18:40:15 INFO - 'HOME': '/home/cltbld', 18:40:15 INFO - 'LANG': 'en_US.UTF-8', 18:40:15 INFO - 'LANGUAGE': 'en_US:en', 18:40:15 INFO - 'LOGNAME': 'cltbld', 18:40:15 INFO - 'MAIL': '/var/mail/cltbld', 18:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:15 INFO - 'MOZ_NO_REMOTE': '1', 18:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:15 INFO - 'NO_EM_RESTART': '1', 18:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:15 INFO - 'PWD': '/builds/slave/test', 18:40:15 INFO - 'SHELL': '/bin/bash', 18:40:15 INFO - 'SHLVL': '1', 18:40:15 INFO - 'TERM': 'linux', 18:40:15 INFO - 'TMOUT': '86400', 18:40:15 INFO - 'USER': 'cltbld', 18:40:15 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', 18:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:15 INFO - '_': '/tools/buildbot/bin/python'} 18:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:15 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)) 18:40:15 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)) 18:40:15 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)) 18:40:15 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)) 18:40:15 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)) 18:40:15 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)) 18:40:15 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)) 18:40:15 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)) 18:40:15 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)) 18:40:15 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)) 18:40:15 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)) 18:40:15 INFO - Cleaning up... 18:40:15 INFO - Return code: 0 18:40:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:40:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd1affbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21aa7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2239790>, '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 0x223a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223ab20>, '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': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', '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 18:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:40:15 INFO - Using env: {'DISPLAY': ':0', 18:40:15 INFO - 'HOME': '/home/cltbld', 18:40:15 INFO - 'LANG': 'en_US.UTF-8', 18:40:15 INFO - 'LANGUAGE': 'en_US:en', 18:40:15 INFO - 'LOGNAME': 'cltbld', 18:40:15 INFO - 'MAIL': '/var/mail/cltbld', 18:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:15 INFO - 'MOZ_NO_REMOTE': '1', 18:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:15 INFO - 'NO_EM_RESTART': '1', 18:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:15 INFO - 'PWD': '/builds/slave/test', 18:40:15 INFO - 'SHELL': '/bin/bash', 18:40:15 INFO - 'SHLVL': '1', 18:40:15 INFO - 'TERM': 'linux', 18:40:15 INFO - 'TMOUT': '86400', 18:40:15 INFO - 'USER': 'cltbld', 18:40:15 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', 18:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:15 INFO - '_': '/tools/buildbot/bin/python'} 18:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:40:15 INFO - Cleaning up... 18:40:15 INFO - Return code: 0 18:40:15 INFO - Running post-action listener: _resource_record_post_action 18:40:15 INFO - Running post-action listener: _start_resource_monitoring 18:40:15 INFO - Starting resource monitoring. 18:40:15 INFO - [mozharness: 2016-10-13 01:40:15.753545Z] Finished create-virtualenv step (success) 18:40:15 INFO - [mozharness: 2016-10-13 01:40:15.754068Z] Running install step. 18:40:15 INFO - Running pre-action listener: _resource_record_pre_action 18:40:15 INFO - Running main action method: install 18:40:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:40:15 INFO - Reading from file tmpfile_stdout 18:40:15 INFO - Detecting whether we're running mozinstall >=1.0... 18:40:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:40:16 INFO - Reading from file tmpfile_stdout 18:40:16 INFO - Output received: 18:40:16 INFO - Usage: mozinstall [options] installer 18:40:16 INFO - Options: 18:40:16 INFO - -h, --help show this help message and exit 18:40:16 INFO - -d DEST, --destination=DEST 18:40:16 INFO - Directory to install application into. [default: 18:40:16 INFO - "/builds/slave/test"] 18:40:16 INFO - --app=APP Application being installed. [default: firefox] 18:40:16 INFO - mkdir: /builds/slave/test/build/application 18:40:16 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'] 18:40:16 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 18:40:33 INFO - Reading from file tmpfile_stdout 18:40:33 INFO - Output received: 18:40:33 INFO - /builds/slave/test/build/application/firefox/firefox 18:40:33 INFO - Running post-action listener: _resource_record_post_action 18:40:33 INFO - [mozharness: 2016-10-13 01:40:33.120049Z] Finished install step (success) 18:40:33 INFO - [mozharness: 2016-10-13 01:40:33.120332Z] Running run-tests step. 18:40:33 INFO - Running pre-action listener: _resource_record_pre_action 18:40:33 INFO - Running main action method: run_tests 18:40:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:40:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:40:33 INFO - Python 2.7.3 18:40:33 INFO - Return code: 0 18:40:33 INFO - grabbing minidump binary from tooltool 18:40:33 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')]} 18:40:33 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 0x2239790>, '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 0x223a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x223ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:40:33 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 18:40:33 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 18:40:33 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 18:40:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:40:33 INFO - Return code: 0 18:40:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:40:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:40:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:40:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:40:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:40:33 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:40:33 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:40:33 INFO - Using env: {'DISPLAY': ':0', 18:40:33 INFO - 'HOME': '/home/cltbld', 18:40:33 INFO - 'LANG': 'en_US.UTF-8', 18:40:33 INFO - 'LANGUAGE': 'en_US:en', 18:40:33 INFO - 'LOGNAME': 'cltbld', 18:40:33 INFO - 'MAIL': '/var/mail/cltbld', 18:40:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:40:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:33 INFO - 'MOZ_NO_REMOTE': '1', 18:40:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:33 INFO - 'NO_EM_RESTART': '1', 18:40:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:33 INFO - 'PWD': '/builds/slave/test', 18:40:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:40:33 INFO - 'SHELL': '/bin/bash', 18:40:33 INFO - 'SHLVL': '1', 18:40:33 INFO - 'TERM': 'linux', 18:40:33 INFO - 'TMOUT': '86400', 18:40:33 INFO - 'USER': 'cltbld', 18:40:33 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037', 18:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:33 INFO - '_': '/tools/buildbot/bin/python'} 18:40:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:40:33 INFO - mozversion application_buildid: 20161012153001 18:40:33 INFO - mozversion application_changeset: d68def1644c1849141ceaa31bc1b811becfbb8da 18:40:33 INFO - mozversion application_display_name: Nightly 18:40:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:40:33 INFO - mozversion application_name: Firefox 18:40:33 INFO - mozversion application_remotingname: firefox 18:40:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:40:33 INFO - mozversion application_vendor: Mozilla 18:40:33 INFO - mozversion application_version: 52.0a1 18:40:33 INFO - mozversion platform_buildid: 20161012153001 18:40:33 INFO - mozversion platform_changeset: d68def1644c1849141ceaa31bc1b811becfbb8da 18:40:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:40:33 INFO - mozversion platform_version: 52.0a1 18:40:33 INFO - using testdate: 1476322833 18:40:33 INFO - actual date: 1476322833 18:40:33 INFO - starting webserver on 'localhost:43403' 18:40:33 INFO - SUITE-START | Running 2 tests 18:40:33 INFO - TEST-START | dromaeo_css 18:40:33 INFO - operating with platform_type : linux_ 18:40:33 INFO - Initialising browser for dromaeo_css test... 18:40:33 INFO - TEST-INFO | started process 8367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp5U9bs/profile http://localhost:43403/getInfo.html) 18:40:37 INFO - PROCESS | 8367 | __metrics Screen width/height:1600/1200 18:40:37 INFO - PROCESS | 8367 | colorDepth:24 18:40:37 INFO - PROCESS | 8367 | Browser inner width/height: 1024/697 18:40:37 INFO - PROCESS | 8367 | __metrics 18:40:38 ERROR - PROCESS | 8367 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 18:40:39 INFO - TEST-INFO | 8367: exit 0 18:40:39 INFO - Browser initialized. 18:40:39 INFO - Running cycle 1/1 for dromaeo_css test... 18:40:39 INFO - TEST-INFO | started process 8490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp5U9bs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:40:51 INFO - PROCESS | 8490 | RSS: Main: 184393728 18:40:51 INFO - PROCESS | 8490 | 18:41:41 INFO - PROCESS | 8490 | 1476322901137 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] 18:43:52 INFO - PROCESS | 8490 | Cycle 1(1): loaded http://localhost:43403/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43403/tests/dromaeo/cssquery-ext.html) 18:43:53 INFO - PROCESS | 8490 | RSS: Main: 202010624 18:43:53 INFO - PROCESS | 8490 | 18:46:55 INFO - PROCESS | 8490 | Cycle 1(1): loaded http://localhost:43403/tests/dromaeo/cssquery-ext.html (next: http://localhost:43403/tests/dromaeo/cssquery-jquery.html) 18:46:56 INFO - PROCESS | 8490 | RSS: Main: 200773632 18:46:56 INFO - PROCESS | 8490 | 18:49:58 INFO - PROCESS | 8490 | Cycle 1(1): loaded http://localhost:43403/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43403/tests/dromaeo/cssquery-mootools.html) 18:49:58 INFO - PROCESS | 8490 | RSS: Main: 199819264 18:49:58 INFO - PROCESS | 8490 | 18:53:00 INFO - PROCESS | 8490 | Cycle 1(1): loaded http://localhost:43403/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43403/tests/dromaeo/cssquery-prototype.html) 18:53:01 INFO - PROCESS | 8490 | RSS: Main: 194084864 18:53:01 INFO - PROCESS | 8490 | 18:56:03 INFO - PROCESS | 8490 | Cycle 1(1): loaded http://localhost:43403/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43403/tests/dromaeo/cssquery-yui.html) 18:56:04 INFO - PROCESS | 8490 | RSS: Main: 197685248 18:56:04 INFO - PROCESS | 8490 | 18:59:07 INFO - PROCESS | 8490 | Cycle 1(1): loaded http://localhost:43403/tests/dromaeo/cssquery-yui.html (next: http://localhost:43403/tests/dromaeo/cssquery-dojo.html) 18:59:07 INFO - PROCESS | 8490 | RSS: Main: 198332416 18:59:07 INFO - PROCESS | 8490 | 18:59:07 INFO - PROCESS | 8490 | __start_tp_report 18:59:07 INFO - PROCESS | 8490 | _x_x_mozilla_page_load 18:59:07 INFO - PROCESS | 8490 | _x_x_mozilla_page_load_details 18:59:07 INFO - PROCESS | 8490 | |i|pagename|runs| 18:59:07 INFO - PROCESS | 8490 | |0;dojo.html;3027.636683597968;3048.893288734894;3055.893043743468;3056.8318742469155;3109.9067027989154;5228.294180285669;5304.230886521457;5384.2731231283815;5390.245365648808;5452.59105567083;5283.894322113555;5292.523672869441;5386.326709161355;5416.756245968931;5485.588580856432;4855.854324370274;4877.853664390056;4896.094222568819;4940.678855874375;4961.900761984758;4737.692050016755;4877.780499877496;4937.629677774164;4942.53045960635;4971.229459433794;4761.190597598382;4807.807687692488;4810.6873053251775;4855.805767769285;4858.659893807435;4785.904281914377;4838.395200599925;4865.19724245499;4912.631552633531;4921.434035085939;4824.421069471686;4833.685810422347;4837.032593481283;4851.199552073939;4868.02639472107;5125.974370128126;5212.609054320941;5219;5273.129933560957;5344.599155063386;5729.455701708331;5783.768649254025;5805.796797112123;5838.5329173666005;5880.882382352372;5864.472197502203;5875.823725288205;5879.441453061952;5885.823425297248;5886.764529418818;5110.514501122388;5439.510444060014;5453.263809385761;5456.372517160498;5465.234867118606;5585.664860108406;5721.170430287585;5756.079027355603;5778.479936805707;5879.970600146972;5566.081596536526;5568.276124103841;5570.693611851306;5578.944210557924;5580.386157522669;5574.749136288877;5614.943850561442;5627.155926610959;5672.120821272627;5687.175359572839;5611.466910643482;5620.831375058755;5672.12082127271;5674.659520428788;5685.459881311269;5518.089515230023;5610.102383618601;5630.07103827872;5634.352049514358;5638.464345887134;4288.50682171548;4306.2894622387585;4315.274774122331;4320.567943205654;4355.368471571668;3759.172981943968;3808.333541630204;3841.8666493384517;3860.1121741999495;3870.670992965573;5368.409474957752;5433.701146436905;5436.293281873332;5471.945280547223;5526.50261476469;5702.087665973424;5737.397573254748;5740.1102829061565;5785.247917770663;5813.215215945793;5324.227986941872;5382.569394448435;5432.6468779529205;5436.281859070465;5496.450354964471;4965.131102057126;4974.552290293818;4991.376077990251;5014.623903207274;5024.296598476216;5970.5223582114195;6017.548683848729;6018.518518518508;6020.939790602126;6025.698715064317;5438;5520.723963801714;5526.419725928719;5842.678652673973;5867.501262392744;5725.341585717696;5781.392953739965;5797.159411885169;5849.298084229919;5863.794767183128;5483.780648774164;5487.176923461513;5488.396276409512;5507.862303442446;5534.142207957773;5612.915806262828;5614.21401003868;5650.971745141248;5654.491095801398;5670.489655930986;5558.194061860927;5614.157876318585;5648.830535083954;5687.20379146928;5752.395998420106;5699.23060386859;5707.942920570741;5713.542916566582;5714.514266287412;5737.225474560881;5388.164834450667;5450.809221677222;5465.836024919259;5606.523445507178;5620.100783874561;5663.4053424391495;5723.02708539541;5745;5801.477866991822;5803.361630220588;5566.805161819317;5595.608307418442;5609.607327487037;5613.073842815889;5618.185363122406 18:59:07 INFO - PROCESS | 8490 | |1;ext.html;576.7145263094769;582.9038208695565;588.496835205899;597.9714890388532;619.1641284266238;38704.419433708485;42403.78798106013;42460.15079698404;42543;42548.36177457333;42139.57860421395;42679.35980960288;42823.5011774588;42827.5010374637;42924.356134658;8808.779780505474;8930.419522731001;8954.417962832395;8956.373053886231;8980.955095224515;8782.253508451757;8785.912140878605;8794.912050879506;8827.823443531126;8829.867551986725;8836.204741573258;8923.10768923109;8936.285097192242;8940.687075952343;8954.059823718513;8856.070112638177;8879.200871921557;8885.333599980027;8891.422057566237;8898.510581917992;8707.738767836974;8796.692115775917;8811.118888111201;8837.513936733478;8839.558022098934;40253.79873100616;40267.798661006804;40359.59640403617;40452.797736011424;40586;3348.96651033489;3373.595168579762;3431.5367425397753;3460.8961731148106;3482.460218666111;31161.94034299801;32028.519572206435;32105.1973700657;32648.6735132648;33312.666873331444;4172.207280616703;4249.681273904439;4362.694611377205;4373.737575745466;4402.449693788277;334264;337294.31352843327;338413;338641;341642;58182;58836.411635883094;58871.112888710784;58937.41062589405;59010.40989590135;61591.69204153951;61793;62112;62313.376866231665;62577.37422625806;14858.777118343234;15068.698626027419;15169.317380717894;15182.46861359847;15211.847881521264;11471.426428678533;11498;11525.366104864146;11540.076793856471;11555.653330400102;16632.83367166337;17446.912765436093;17481.300747970192;17519.124043797758;17566.91216543909;6011.6693581853415;6102.877942441126;6268.968655156695;6292.653904035231;6310.968445157745;873.9344549158839;965.3347974743511;979.857920601523;990.2573070197352;1038.1850247555633;31550.684493154775;31760.841195793873;31801;31948.94190111201;32412;1041.7551875309296;1046.8115739166872;1061.400308825511;1067.215596536545;1110.5835311758092;15588.92205538965;16484.763991236854;16508;16748.330066797193;16836.494905152864;463015;464930;465323;466607;469716;57729.71135144382;57796.711016445486;57896.42103578994;57960.30595410638;58102.70948645314;1264.9810252846214;1267.847858257015;1313.1661395014044;1314.9342532873318;1325.870944570812;29664;30376.734832041984;31665.366692665557;31697.683023169473;32444.35111297808;50464.49535504598;51348.48651513437;51393.743031284605;51400.48599514107;51567.226491601905;407420;408240;408808;409852;410825;40190.583800377295;40229.39655905105;40533.59466405416;40844;41440.79279603583;46667;46981.295280570135;48159.75920120377;48399.5160048395;48458.0616775325;38469.4229586562;38949;39553.604463954995;40920.38619420651;41025.589744103374;38138.61861381351;39137.41293880537;39427.80286098551;39660.60339396685;40644.796776017116;39530.60469395269;40392.39411408772;41572.58427415687;41662.791686041375;41665.79167104145;30938.690613093582;34463.65536344604;35634.82182589071;36234;37019;26964.303569642878;27831.30421739473;27954.440911182068;28004.29989250285;28308.06125252863 18:59:07 INFO - PROCESS | 8490 | |2;jquery.html;386.4936932618272;391.70426328122284;403.2479425870751;404.13515077733643;418.2617679795162;17501.56246093847;18315.816841831576;18897.14962826676;18993;19075.236990520396;18035.188416521254;18252.817471825278;18253.634927301446;18284.268629254846;18335.908320458413;5536.446355364452;5538;5792.6524408535415;5796.623219490741;5802.767889284445;5832.766689332421;5867.501262392701;5878.177055212273;5888.440598143169;5895.174675545427;5746.597738158331;5871.618344807595;6252.812415627538;6298.559100862942;6349.61902285862;5954.570902983296;6212.502999760009;6233.71948262327;6267.43593076623;6268.561200715952;5614.157876318544;5686.3744988051285;5691.089425691869;5691.516221121168;5710.914336284959;21043;21285.893570532204;21291.14835406582;21735;21919.12323507058;2084.343431818972;2160.6002889465344;2343.086196383412;2362.9527409451885;2455.1652438170927;9778.022197780236;9910.562968369546;10183.694489165337;10314.587416503331;10682.412467314294;1879.3985924504163;1935.3032908153054;1969.1827891425041;1992.7708313543983;2024.8886311252875;71691.92462113072;77180.61409692971;78949.60525197338;78958.60520697417;80349.2664505396;10716.839247411295;10869.456527173768;11055.502502387251;11137.832932505857;11244.550217991353;15343.619074283368;15387.307571159325;15453;15482.690346193012;15508.689826203412;7562.962185189039;7747.806304842424;7797.727079552188;7934.2859142677435;7959.164287749819;7182.676779544933;7210.603416812126;7221.169565499929;7442.95318787327;7452.515586486861;4607.470140933769;4623.838165664186;4719.126961512131;4732.929006064912;4778.307145463888;1954.208545539059;1956.628240634275;2007.1569940624972;2044.6524090904284;2071.596038772425;804.3605333759558;826.8801023851507;861.2291998661289;899.8425275576878;935.036911980661;16523.586910327336;17308.307667693152;17997.820021799875;18104.185311661007;18752.62494750125;920.4569304110607;937.6202637931649;947.0434860790651;947.8009617980301;976.2824324121765;9530.475823829756;10158.39049657023;10265.538050787583;10295.845562316572;10340.689779306633;400744;401949;408326;416171;423766;82207.17792821996;86006;86532;90048.95104895104;93855.53072234595;1014.0923873133504;1039.3555995282973;1063.0591926145262;1066.9786604267872;1068.6687126990657;16235.675286494441;16414.425495107615;16874.240659170122;17028.659426811148;17109.82890171132;39031.609683902796;39291.80354098326;40501.39247911225;40552;41874.79062604668;53024.73487632537;53952.46047539474;57624.423755761905;57908;58981.11528326993;7300.415966722543;7577.659005344883;7792.415568832474;7887.526748395115;8114.878276825734;9519.048095190425;12385.876141238472;12518.874811251771;12827.679308017374;12832.55086071983;11197.496112675111;11390.544378224778;11411.25826821254;11642.476088576204;11817.231879927776;11060.446977651247;11102.555897764321;11251;11340.376279304717;11641;11089.667309980714;11112.22214444981;11244.493997769956;11250.831237531607;12063.155579109378;7763.650635721293;7959.801004974922;7978.281954624112;7984.840303193788;8244.628991695508;9799.363041402286;11149;11228.719282017688;11376.94311528437;11386.146039046938 18:59:07 INFO - PROCESS | 8490 | |3;mootools.html;1432.405551696046;1479.9936043490425;1587.745960646296;1681.5964168599523;1691.2220378625832;7780.299773020427;7998.240167184108;8937.10628937106;9469.621215151394;9471.81056378873;8734.737957861274;9081.137291957253;9091.909080909189;9362.765930851732;9382.765430864232;2322.268485427089;2359.905603775847;2359.9646005309933;2361.4332560185603;2366.9763302367014;2324.2562380038394;2332.125452955142;2339.883005849709;2347.4600841806396;2357.1867705641525;2339.5671800716923;2341.7892389684926;2363.444590521226;2364.3498038039506;2369.6445533170076;2279.726432828071;2299.9540009199804;2308.3421224950894;2317.3627252505694;2318.431984163882;2276.5105502317083;2282.931512054641;2284.3946354216146;2288.7711228877147;2320.8491448055993;9136.725898223063;9257.814843703156;9262.907370926272;9371.34400591959;9386.108319709616;5265;5417;5417.404085550586;5422.8915421691345;5430.5927055471;3323.8670453181844;3328.5506456628286;3530.7881527108457;3535.222251104753;3536.381133301662;1044.383941765374;1084.7613525024483;1114.7826173896094;1119.5353928119903;1132.2357408749062;12996.675083122998;13076.542321018718;13076.542321018815;13087.86912130876;13245.86754132456;4554.4990051094355;4728.101660684459;4829.227323628203;4837.540433658797;4851.51484851512;10974.835377469344;10975;11037.39294338803;11038.834417483744;11042.834357484644;5421.512063914267;5428.104362780097;5466.9179962300595;5484;5519.779208831682;4331.177076355482;4447.577480139446;4779.856604301807;4988.5260900214425;4996.175631020914;3933.3116704576582;3977.423273625308;4020.5175378954714;4071.3485842265686;4124.4019617155345;1270.7394984028251;1291.289790615158;1293.489071816627;1294.7539967406162;1296.5786119511008;724.9166345870292;858.5321000054985;874.4010352908278;880.9383343165916;898.7169041751828;5374.54316383104;5404.83785486436;5405.891882162335;5421.647592906448;5454.863628409322;433.5058033841423;442.1488634378808;444.4244703109481;446.2703479810468;451.3568165364343;3543.291341731664;3552.2717842842158;3650.5071815305123;3653.214558869856;3705.110773414361;11117.332960022424;11450.599229026944;11549.076073914066;11638.41807909601;11654.76690466186;11528.308301501937;11577.247478913843;11578.536858525564;11643.41782910851;11674.824877626843;8444.692092616038;8513.616887240089;8567.400281980326;8625.0943650917;8672.132786721404;5144.6913185209005;5208.739563021758;5273.393559740679;5290.100682883996;5307.9734601326745;10258.820235672694;10480.10919071857;10498.107660848913;10509.316894402145;10635.042846143884;10473.68578942633;10985;10985.945070274598;11002.119830413707;11098.778024439305;8203.671853126047;8214.917850821415;8245.257926786378;8315.12691167443;8338.66645334204;8935.106489351012;8978.730638080868;9037.864432033657;9039.774005649911;9045.638174472948;7886.369090472634;7931.286184243446;7995.880061798961;8169.959150204211;8397.286230670217;7916.525008499509;7937.960310198412;7997.960010199912;8106.918930810616;8157.510549367057;6958.130233720785;7289.671964761705;7368.1526624438875;7390.408767298496;7412.147603025721;4897.608191344612;4898.951010489849;4905.730184839868;5023.773930173078;5117.948820511747;4933.703977761345;4971.279164521196;4972.055309491185;5038.974805126098;5041.6722913010535 18:59:07 INFO - PROCESS | 8490 | |4;prototype.html;324.8927853808242;332.9317489914567;335.1955307262571;338.1883479648843;341.39743352981975;5380.596455265861;5484.451554844523;5590.524805391541;5628.409017053212;5676.347220069693;5356.491133342336;5476.67139971601;5481.479259470354;5527.861803454915;5535.557155427567;4346.21768081746;4350.825966961318;4354;4367.519572846984;4368.475782906055;4216.367544868279;4286.892827679318;4324.481062272532;4351.6953813233085;4376.649868010568;4281.935770963422;4284.764337961411;4289.613934745872;4295.312749960007;4302.849400270991;4262.9147417051645;4283.336082907154;4289.206496798102;4302.096559722462;4321.459817522809;3712.832922518493;3832.4442955771256;3836.48458858752;3850.152966347399;3869.8452061917487;5310.0441920454305;5335.946640533583;5348.277982472394;5355.384130824966;5361.356637203521;4844.878878028042;4861.659683822134;4877.756112194376;4880.877978050542;4933.136701077333;5509.559235261169;5614.466625670596;5635.098384258499;5672.5178359839465;5691;4089.4683691120263;4103.179364127186;4110.403991421227;4113.095119073799;4129.009037830929;5865.35481097079;5894.3810899855325;5899.439553242435;5917.319508256563;5917.349091599964;4179.6029377209115;4218.683598730107;4278.9088782360295;4282.550332215135;4308.590683885026;4284.571542845691;4319.762413067311;4337.65766486094;4354.673399495051;4357.106793107406;4891.461939186686;4891.486393928657;4898.779554920037;4905.632077594195;4938;5544.251526043932;5717.371089180187;5726.455986681259;5746.367899531048;5765.625234359753;1478.8447213042691;1482.7331080405631;1494.4022391043452;1494.8355680875095;1499.8500149985132;928.9303302252358;957.2198658093631;957.6025949231131;964.1515466389533;977.0180968126987;4817.710937343701;4883.389576302962;4890.263956295535;4906.92639610399;4979.950200497949;5168.3539557555305;5217.165253559412;5230.169440695726;5234.691327168208;5283.233931079972;4619.538046195421;4817.759112044454;4960.603151747851;4963.677360971526;4967.5777558907175;2760.4617099665775;2764.5023895698564;2786.944261114807;2789.17719272815;2839.8640543782653;5353.9732301338245;5370.355557333145;5390.628123625592;5434.402215756264;5464.934337804169;5244.898571299994;5263.131583288791;5753.280839895013;6102.633841969496;6121.326654068049;6157.9384206158265;6157.96921015401;6159.692015399212;6168.383161683885;6206.286277078104;5626.803061892814;5957.553183511341;5957.672328022;5972.522198224218;5992.262243949206;5859.619124756877;5861.062230043172;5866.735996880066;5882.941170588239;5887.322957859729;6093.146959425595;6159.72281247336;6166.876662466815;6168.568200225941;6201.10084037803;3930.7248492605245;3941.7240793144206;4162.958370416257;4181.330987042059;4198.160367926488;5909.2908850938165;5913.852153696192;5914.290285165635;5966.224390829165;6030.758769649165;5774.372660439406;5792.94207057924;5904.822855314347;5914.142449344735;5918.461200087922;5702.857428564153;5733.971330143323;5750.798722044876;5753.913691294718;5765.135229715408;5653.802116925888;5710.457506536873;5727.5417966561745;5735.799247026334;5803.9419605803405;5645.830625081254;5742.19609254713;5774.440900956634;5808.82573522795;5817.680027598522;5654.123610840326;5660.632058916157;5663.801766938137;5672.744726487235;5681.744321505625 18:59:07 INFO - PROCESS | 8490 | |5;yui.html;697.2191145916573;717.6591119218372;725.3798002707681;740.1451323721101;790.083503136362;15531.378744850206;16590.170491475437;16599.419020334277;16625.667486650258;16634.916825415872;14923.477678281262;14968.401263949429;14971.401143954256;15101.546953591409;15113.244337783095;782.4131901074209;792.2592376128339;792.3581898662073;792.6750032486682;792.7066985215479;809.0372456776417;815.6859609050499;820.1593366799019;821.7822277096544;822.5475988206492;855.5935930433056;859.9852174434166;860.290260535058;861.3668953319306;862.9482231066124;842.7176895739934;849.8045449546577;850.587465079436;851.0978362935277;852.4544291653347;616.9691515424256;618.7153909201772;619.071392910634;622.0265284829228;624.073251221935;15900.125493097876;16149;16166;16171.676566468605;16188.676226475405;14390.71218575633;14412.855871441256;14429.49496767608;14432.27838608076;14571.344289506998;11839.230450020807;11934.403279835973;12005.87994120065;12206.328651924141;12792.616221513277;3809.4476300936485;3834.7699138051526;3922.627350401736;3999.42008408782;4009.158076803875;81385.59307203426;83564.58217708934;84182;84283.57858210731;84759;10614.310069845435;10791.676249712522;10814.891851081546;10927;11027.338359698284;21553.461163471038;21635.459113521974;21666.674999875013;21692;21744.78255217459;8253.463524870864;8268.875966860502;8772.517511536927;8782.253508451726;8802.515861627671;4278.44380230568;4324.545922678137;4377.387165796791;4437.068215674744;4580.748058856728;3548.591911930161;3651.3610118229203;3682.226732386229;3684.9263014739554;3689.3728066228805;587.6386022596158;596.9611975221596;603.6981509245377;616.442119881508;624.2228425610144;491.50112635674816;524.8950209957948;532.6351449257194;619.9349068347849;696.7247937064831;9560.176069151514;9583.329166958247;9701.660441884642;9758.853617195748;9837.262205334628;582.8134996801068;600.2287061126432;675.8006388115517;678.5792808458689;711.3100292716057;4317.120855444263;4482.386340917267;4622.976885115553;4805.8558243252755;4868.14807408702;103737;118373;121250.39374803069;122390;124954;110505.44747276213;111061;112525.43737281261;114132;114660;61508;91285.54357228172;91396.5430172845;92076;97483;9053.321000924825;9099.954500227457;9323.953380233055;9325.533723313943;9349.158575728217;52725.78193744568;52800.47199527956;52835.735821320646;53937;55772.442275578345;69756;78458.6077069611;79951.60024199841;81408;83050.16949830424;11467.483963221508;11489.138314626269;11522.76954460923;11640.649952091835;11863.288202707865;12471.688207794878;12929.224246545238;13167.934160329138;13394.129381590166;13553.525626603021;12440;12534.937325313314;12822.743545129231;12954.093213475344;13600.591982240549;11920.880791192323;12052.819207712068;12066.577669781516;12468.501259949864;12865.549705760253;11351.318920864775;12272.140950133406;12356.814647780111;13102.803457947948;13539.323033848465;9615.423074615546;9791.363561368487;9854.310198286052;9888.456134912649;9968.900310997087;10355.94822025885;10787.568497260021;10829.945850271013;10963;11037 18:59:07 INFO - PROCESS | 8490 | __end_tp_report 18:59:07 INFO - PROCESS | 8490 | __start_cc_report 18:59:07 INFO - PROCESS | 8490 | _x_x_mozilla_cycle_collect,321 18:59:07 INFO - PROCESS | 8490 | __end_cc_report 18:59:07 INFO - PROCESS | 8490 | __startTimestamp1476323947755__endTimestamp 18:59:07 INFO - PROCESS | 8490 | 18:59:07 INFO - PROCESS | 8490 | ------- Summary: start ------- 18:59:07 INFO - PROCESS | 8490 | Number of tests: 6 18:59:07 INFO - PROCESS | 8490 | 18:59:07 INFO - PROCESS | 8490 | [#0] dojo.html Cycles:165 Average:5309.10 Median:5518.09 stddev:615.72 (11.2%) stddev-sans-first:591.02 18:59:07 INFO - PROCESS | 8490 | Values: 3027.6 3048.9 3055.9 3056.8 3109.9 5228.3 5304.2 5384.3 5390.2 5452.6 5283.9 5292.5 5386.3 5416.8 5485.6 4855.9 4877.9 4896.1 4940.7 4961.9 4737.7 4877.8 4937.6 4942.5 4971.2 4761.2 4807.8 4810.7 4855.8 4858.7 4785.9 4838.4 4865.2 4912.6 4921.4 4824.4 4833.7 4837.0 4851.2 4868.0 5126.0 5212.6 5219.0 5273.1 5344.6 5729.5 5783.8 5805.8 5838.5 5880.9 5864.5 5875.8 5879.4 5885.8 5886.8 5110.5 5439.5 5453.3 5456.4 5465.2 5585.7 5721.2 5756.1 5778.5 5880.0 5566.1 5568.3 5570.7 5578.9 5580.4 5574.7 5614.9 5627.2 5672.1 5687.2 5611.5 5620.8 5672.1 5674.7 5685.5 5518.1 5610.1 5630.1 5634.4 5638.5 4288.5 4306.3 4315.3 4320.6 4355.4 3759.2 3808.3 3841.9 3860.1 3870.7 5368.4 5433.7 5436.3 5471.9 5526.5 5702.1 5737.4 5740.1 5785.2 5813.2 5324.2 5382.6 5432.6 5436.3 5496.5 4965.1 4974.6 4991.4 5014.6 5024.3 5970.5 6017.5 6018.5 6020.9 6025.7 5438.0 5520.7 5526.4 5842.7 5867.5 5725.3 5781.4 5797.2 5849.3 5863.8 5483.8 5487.2 5488.4 5507.9 5534.1 5612.9 5614.2 5651.0 5654.5 5670.5 5558.2 5614.2 5648.8 5687.2 5752.4 5699.2 5707.9 5713.5 5714.5 5737.2 5388.2 5450.8 5465.8 5606.5 5620.1 5663.4 5723.0 5745.0 5801.5 5803.4 5566.8 5595.6 5609.6 5613.1 5618.2 18:59:07 INFO - PROCESS | 8490 | 18:59:07 INFO - PROCESS | 8490 | [#1] ext.html Cycles:180 Average:57134.72 Median:225438.79 stddev:107641.91 (47.7%) stddev-sans-first:107860.12 18:59:07 INFO - PROCESS | 8490 | Values: 576.7 582.9 588.5 598.0 619.2 38704.4 42403.8 42460.2 42543.0 42548.4 42139.6 42679.4 42823.5 42827.5 42924.4 8808.8 8930.4 8954.4 8956.4 8981.0 8782.3 8785.9 8794.9 8827.8 8829.9 8836.2 8923.1 8936.3 8940.7 8954.1 8856.1 8879.2 8885.3 8891.4 8898.5 8707.7 8796.7 8811.1 8837.5 8839.6 40253.8 40267.8 40359.6 40452.8 40586.0 3349.0 3373.6 3431.5 3460.9 3482.5 31161.9 32028.5 32105.2 32648.7 33312.7 4172.2 4249.7 4362.7 4373.7 4402.4 334264.0 337294.3 338413.0 338641.0 341642.0 58182.0 58836.4 58871.1 58937.4 59010.4 61591.7 61793.0 62112.0 62313.4 62577.4 14858.8 15068.7 15169.3 15182.5 15211.8 11471.4 11498.0 11525.4 11540.1 11555.7 16632.8 17446.9 17481.3 17519.1 17566.9 6011.7 6102.9 6269.0 6292.7 6311.0 873.9 965.3 979.9 990.3 1038.2 31550.7 31760.8 31801.0 31948.9 32412.0 1041.8 1046.8 1061.4 1067.2 1110.6 15588.9 16484.8 16508.0 16748.3 16836.5 463015.0 464930.0 465323.0 466607.0 469716.0 57729.7 57796.7 57896.4 57960.3 58102.7 1265.0 1267.8 1313.2 1314.9 1325.9 29664.0 30376.7 31665.4 31697.7 32444.4 50464.5 51348.5 51393.7 51400.5 51567.2 407420.0 408240.0 408808.0 409852.0 410825.0 40190.6 40229.4 40533.6 40844.0 41440.8 46667.0 46981.3 48159.8 48399.5 48458.1 38469.4 38949.0 39553.6 40920.4 41025.6 38138.6 39137.4 39427.8 39660.6 40644.8 39530.6 40392.4 41572.6 41662.8 41665.8 30938.7 34463.7 35634.8 36234.0 37019.0 26964.3 27831.3 27954.4 28004.3 28308.1 18:59:07 INFO - PROCESS | 8490 | 18:59:07 INFO - PROCESS | 8490 | [#2] jquery.html Cycles:180 Average:26195.31 Median:201176.12 stddev:68001.54 (33.8%) stddev-sans-first:68164.70 18:59:07 INFO - PROCESS | 8490 | Values: 386.5 391.7 403.2 404.1 418.3 17501.6 18315.8 18897.1 18993.0 19075.2 18035.2 18252.8 18253.6 18284.3 18335.9 5536.4 5538.0 5792.7 5796.6 5802.8 5832.8 5867.5 5878.2 5888.4 5895.2 5746.6 5871.6 6252.8 6298.6 6349.6 5954.6 6212.5 6233.7 6267.4 6268.6 5614.2 5686.4 5691.1 5691.5 5710.9 21043.0 21285.9 21291.1 21735.0 21919.1 2084.3 2160.6 2343.1 2363.0 2455.2 9778.0 9910.6 10183.7 10314.6 10682.4 1879.4 1935.3 1969.2 1992.8 2024.9 71691.9 77180.6 78949.6 78958.6 80349.3 10716.8 10869.5 11055.5 11137.8 11244.6 15343.6 15387.3 15453.0 15482.7 15508.7 7563.0 7747.8 7797.7 7934.3 7959.2 7182.7 7210.6 7221.2 7443.0 7452.5 4607.5 4623.8 4719.1 4732.9 4778.3 1954.2 1956.6 2007.2 2044.7 2071.6 804.4 826.9 861.2 899.8 935.0 16523.6 17308.3 17997.8 18104.2 18752.6 920.5 937.6 947.0 947.8 976.3 9530.5 10158.4 10265.5 10295.8 10340.7 400744.0 401949.0 408326.0 416171.0 423766.0 82207.2 86006.0 86532.0 90049.0 93855.5 1014.1 1039.4 1063.1 1067.0 1068.7 16235.7 16414.4 16874.2 17028.7 17109.8 39031.6 39291.8 40501.4 40552.0 41874.8 53024.7 53952.5 57624.4 57908.0 58981.1 7300.4 7577.7 7792.4 7887.5 8114.9 9519.0 12385.9 12518.9 12827.7 12832.6 11197.5 11390.5 11411.3 11642.5 11817.2 11060.4 11102.6 11251.0 11340.4 11641.0 11089.7 11112.2 11244.5 11250.8 12063.2 7763.7 7959.8 7978.3 7984.8 8244.6 9799.4 11149.0 11228.7 11376.9 11386.1 18:59:07 INFO - PROCESS | 8490 | 18:59:07 INFO - PROCESS | 8490 | [#3] mootools.html Cycles:180 Average:5941.12 Median:448.81 stddev:3561.90 (793.6%) stddev-sans-first:3555.78 18:59:07 INFO - PROCESS | 8490 | Values: 1432.4 1480.0 1587.7 1681.6 1691.2 7780.3 7998.2 8937.1 9469.6 9471.8 8734.7 9081.1 9091.9 9362.8 9382.8 2322.3 2359.9 2360.0 2361.4 2367.0 2324.3 2332.1 2339.9 2347.5 2357.2 2339.6 2341.8 2363.4 2364.3 2369.6 2279.7 2300.0 2308.3 2317.4 2318.4 2276.5 2282.9 2284.4 2288.8 2320.8 9136.7 9257.8 9262.9 9371.3 9386.1 5265.0 5417.0 5417.4 5422.9 5430.6 3323.9 3328.6 3530.8 3535.2 3536.4 1044.4 1084.8 1114.8 1119.5 1132.2 12996.7 13076.5 13076.5 13087.9 13245.9 4554.5 4728.1 4829.2 4837.5 4851.5 10974.8 10975.0 11037.4 11038.8 11042.8 5421.5 5428.1 5466.9 5484.0 5519.8 4331.2 4447.6 4779.9 4988.5 4996.2 3933.3 3977.4 4020.5 4071.3 4124.4 1270.7 1291.3 1293.5 1294.8 1296.6 724.9 858.5 874.4 880.9 898.7 5374.5 5404.8 5405.9 5421.6 5454.9 433.5 442.1 444.4 446.3 451.4 3543.3 3552.3 3650.5 3653.2 3705.1 11117.3 11450.6 11549.1 11638.4 11654.8 11528.3 11577.2 11578.5 11643.4 11674.8 8444.7 8513.6 8567.4 8625.1 8672.1 5144.7 5208.7 5273.4 5290.1 5308.0 10258.8 10480.1 10498.1 10509.3 10635.0 10473.7 10985.0 10985.9 11002.1 11098.8 8203.7 8214.9 8245.3 8315.1 8338.7 8935.1 8978.7 9037.9 9039.8 9045.6 7886.4 7931.3 7995.9 8170.0 8397.3 7916.5 7938.0 7998.0 8106.9 8157.5 6958.1 7289.7 7368.2 7390.4 7412.1 4897.6 4899.0 4905.7 5023.8 5117.9 4933.7 4971.3 4972.1 5039.0 5041.7 18:59:07 INFO - PROCESS | 8490 | 18:59:07 INFO - PROCESS | 8490 | [#4] prototype.html Cycles:180 Average:4769.02 Median:5354.68 stddev:1405.18 (26.2%) stddev-sans-first:1368.96 18:59:07 INFO - PROCESS | 8490 | Values: 324.9 332.9 335.2 338.2 341.4 5380.6 5484.5 5590.5 5628.4 5676.3 5356.5 5476.7 5481.5 5527.9 5535.6 4346.2 4350.8 4354.0 4367.5 4368.5 4216.4 4286.9 4324.5 4351.7 4376.6 4281.9 4284.8 4289.6 4295.3 4302.8 4262.9 4283.3 4289.2 4302.1 4321.5 3712.8 3832.4 3836.5 3850.2 3869.8 5310.0 5335.9 5348.3 5355.4 5361.4 4844.9 4861.7 4877.8 4880.9 4933.1 5509.6 5614.5 5635.1 5672.5 5691.0 4089.5 4103.2 4110.4 4113.1 4129.0 5865.4 5894.4 5899.4 5917.3 5917.3 4179.6 4218.7 4278.9 4282.6 4308.6 4284.6 4319.8 4337.7 4354.7 4357.1 4891.5 4891.5 4898.8 4905.6 4938.0 5544.3 5717.4 5726.5 5746.4 5765.6 1478.8 1482.7 1494.4 1494.8 1499.9 928.9 957.2 957.6 964.2 977.0 4817.7 4883.4 4890.3 4906.9 4980.0 5168.4 5217.2 5230.2 5234.7 5283.2 4619.5 4817.8 4960.6 4963.7 4967.6 2760.5 2764.5 2786.9 2789.2 2839.9 5354.0 5370.4 5390.6 5434.4 5464.9 5244.9 5263.1 5753.3 6102.6 6121.3 6157.9 6158.0 6159.7 6168.4 6206.3 5626.8 5957.6 5957.7 5972.5 5992.3 5859.6 5861.1 5866.7 5882.9 5887.3 6093.1 6159.7 6166.9 6168.6 6201.1 3930.7 3941.7 4163.0 4181.3 4198.2 5909.3 5913.9 5914.3 5966.2 6030.8 5774.4 5792.9 5904.8 5914.1 5918.5 5702.9 5734.0 5750.8 5753.9 5765.1 5653.8 5710.5 5727.5 5735.8 5803.9 5645.8 5742.2 5774.4 5808.8 5817.7 5654.1 5660.6 5663.8 5672.7 5681.7 18:59:07 INFO - PROCESS | 8490 | 18:59:07 INFO - PROCESS | 8490 | [#5] yui.html Cycles:180 Average:21484.27 Median:4531.57 stddev:32079.14 (707.9%) stddev-sans-first:32131.16 18:59:07 INFO - PROCESS | 8490 | Values: 697.2 717.7 725.4 740.1 790.1 15531.4 16590.2 16599.4 16625.7 16634.9 14923.5 14968.4 14971.4 15101.5 15113.2 782.4 792.3 792.4 792.7 792.7 809.0 815.7 820.2 821.8 822.5 855.6 860.0 860.3 861.4 862.9 842.7 849.8 850.6 851.1 852.5 617.0 618.7 619.1 622.0 624.1 15900.1 16149.0 16166.0 16171.7 16188.7 14390.7 14412.9 14429.5 14432.3 14571.3 11839.2 11934.4 12005.9 12206.3 12792.6 3809.4 3834.8 3922.6 3999.4 4009.2 81385.6 83564.6 84182.0 84283.6 84759.0 10614.3 10791.7 10814.9 10927.0 11027.3 21553.5 21635.5 21666.7 21692.0 21744.8 8253.5 8268.9 8772.5 8782.3 8802.5 4278.4 4324.5 4377.4 4437.1 4580.7 3548.6 3651.4 3682.2 3684.9 3689.4 587.6 597.0 603.7 616.4 624.2 491.5 524.9 532.6 619.9 696.7 9560.2 9583.3 9701.7 9758.9 9837.3 582.8 600.2 675.8 678.6 711.3 4317.1 4482.4 4623.0 4805.9 4868.1 103737.0 118373.0 121250.4 122390.0 124954.0 110505.4 111061.0 112525.4 114132.0 114660.0 61508.0 91285.5 91396.5 92076.0 97483.0 9053.3 9100.0 9324.0 9325.5 9349.2 52725.8 52800.5 52835.7 53937.0 55772.4 69756.0 78458.6 79951.6 81408.0 83050.2 11467.5 11489.1 11522.8 11640.6 11863.3 12471.7 12929.2 13167.9 13394.1 13553.5 12440.0 12534.9 12822.7 12954.1 13600.6 11920.9 12052.8 12066.6 12468.5 12865.5 11351.3 12272.1 12356.8 13102.8 13539.3 9615.4 9791.4 9854.3 9888.5 9968.9 10355.9 10787.6 10829.9 10963.0 11037.0 18:59:07 INFO - PROCESS | 8490 | -------- Summary: end -------- 18:59:07 INFO - PROCESS | 8490 | 18:59:08 INFO - TEST-INFO | 8490: exit 0 18:59:08 INFO - TEST-OK | dromaeo_css | took 1115357ms 18:59:08 INFO - TEST-START | kraken 18:59:08 INFO - operating with platform_type : linux_ 18:59:08 INFO - Initialising browser for kraken test... 18:59:08 INFO - TEST-INFO | started process 8857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVqWjJi/profile http://localhost:43403/getInfo.html) 18:59:13 INFO - PROCESS | 8857 | __metrics Screen width/height:1600/1200 18:59:13 INFO - PROCESS | 8857 | colorDepth:24 18:59:13 INFO - PROCESS | 8857 | Browser inner width/height: 1024/697 18:59:13 INFO - PROCESS | 8857 | __metrics 18:59:13 ERROR - PROCESS | 8857 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 18:59:14 INFO - TEST-INFO | 8857: exit 0 18:59:14 INFO - Browser initialized. 18:59:14 INFO - Running cycle 1/1 for kraken test... 18:59:14 INFO - TEST-INFO | started process 8983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVqWjJi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:59:27 INFO - PROCESS | 8983 | RSS: Main: 184455168 18:59:27 INFO - PROCESS | 8983 | 18:59:29 INFO - PROCESS | 8983 | Cycle 1(1): loaded http://localhost:43403/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43403/tests/kraken/driver.html?testName=audio-beat-detection) 18:59:30 INFO - PROCESS | 8983 | RSS: Main: 197783552 18:59:30 INFO - PROCESS | 8983 | 18:59:33 INFO - PROCESS | 8983 | Cycle 1(1): loaded http://localhost:43403/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43403/tests/kraken/driver.html?testName=audio-dft) 18:59:34 INFO - PROCESS | 8983 | RSS: Main: 196829184 18:59:34 INFO - PROCESS | 8983 | 18:59:36 INFO - PROCESS | 8983 | Cycle 1(1): loaded http://localhost:43403/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43403/tests/kraken/driver.html?testName=audio-fft) 18:59:37 INFO - PROCESS | 8983 | RSS: Main: 191643648 18:59:37 INFO - PROCESS | 8983 | 18:59:39 INFO - PROCESS | 8983 | Cycle 1(1): loaded http://localhost:43403/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43403/tests/kraken/driver.html?testName=audio-oscillator) 18:59:40 INFO - PROCESS | 8983 | RSS: Main: 192684032 18:59:40 INFO - PROCESS | 8983 | 18:59:42 INFO - PROCESS | 8983 | Cycle 1(1): loaded http://localhost:43403/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43403/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:59:43 INFO - PROCESS | 8983 | RSS: Main: 192569344 18:59:43 INFO - PROCESS | 8983 | 18:59:46 INFO - PROCESS | 8983 | Cycle 1(1): loaded http://localhost:43403/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43403/tests/kraken/driver.html?testName=imaging-darkroom) 18:59:46 INFO - PROCESS | 8983 | RSS: Main: 192630784 18:59:46 INFO - PROCESS | 8983 | 18:59:50 INFO - PROCESS | 8983 | Cycle 1(1): loaded http://localhost:43403/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43403/tests/kraken/driver.html?testName=imaging-desaturate) 18:59:50 INFO - PROCESS | 8983 | RSS: Main: 190939136 18:59:50 INFO - PROCESS | 8983 | 18:59:53 INFO - PROCESS | 8983 | Cycle 1(1): loaded http://localhost:43403/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43403/tests/kraken/driver.html?testName=json-parse-financial) 18:59:54 INFO - PROCESS | 8983 | RSS: Main: 191778816 18:59:54 INFO - PROCESS | 8983 | 18:59:55 INFO - PROCESS | 8983 | Cycle 1(1): loaded http://localhost:43403/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43403/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:59:56 INFO - PROCESS | 8983 | RSS: Main: 192278528 18:59:56 INFO - PROCESS | 8983 | 18:59:58 INFO - PROCESS | 8983 | Cycle 1(1): loaded http://localhost:43403/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43403/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:59:59 INFO - PROCESS | 8983 | RSS: Main: 192622592 18:59:59 INFO - PROCESS | 8983 | 19:00:01 INFO - PROCESS | 8983 | Cycle 1(1): loaded http://localhost:43403/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43403/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:00:01 INFO - PROCESS | 8983 | RSS: Main: 192020480 19:00:01 INFO - PROCESS | 8983 | 19:00:04 INFO - PROCESS | 8983 | Cycle 1(1): loaded http://localhost:43403/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:00:05 INFO - PROCESS | 8983 | RSS: Main: 193490944 19:00:05 INFO - PROCESS | 8983 | 19:00:08 INFO - PROCESS | 8983 | Cycle 1(1): loaded http://localhost:43403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:00:08 INFO - PROCESS | 8983 | RSS: Main: 193163264 19:00:08 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | Cycle 1(1): loaded http://localhost:43403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43403/tests/kraken/driver.html?testName=ai-astar) 19:00:10 INFO - PROCESS | 8983 | RSS: Main: 194359296 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | __start_tp_report 19:00:10 INFO - PROCESS | 8983 | _x_x_mozilla_page_load 19:00:10 INFO - PROCESS | 8983 | _x_x_mozilla_page_load_details 19:00:10 INFO - PROCESS | 8983 | |i|pagename|runs| 19:00:10 INFO - PROCESS | 8983 | |0;ai-astar;107;115;113;112;111;111;112;111;109;111 19:00:10 INFO - PROCESS | 8983 | |1;audio-beat-detection;157;129;127;173;126;124;126;125;155;124 19:00:10 INFO - PROCESS | 8983 | |2;audio-dft;165;162;164;173;163;163;162;163;161;162 19:00:10 INFO - PROCESS | 8983 | |3;audio-fft;76;76;76;107;77;75;76;75;103;75 19:00:10 INFO - PROCESS | 8983 | |4;audio-oscillator;83;84;110;83;83;83;108;83;83;112 19:00:10 INFO - PROCESS | 8983 | |5;imaging-gaussian-blur;118;117;118;118;117;118;117;118;118;119 19:00:10 INFO - PROCESS | 8983 | |6;imaging-darkroom;146;149;147;147;147;148;148;147;147;147 19:00:10 INFO - PROCESS | 8983 | |7;imaging-desaturate;96;97;96;97;97;96;103;97;97;95 19:00:10 INFO - PROCESS | 8983 | |8;json-parse-financial;54;54;58;59;54;56;58;55;54;58 19:00:10 INFO - PROCESS | 8983 | |9;json-stringify-tinderbox;61;62;62;62;62;61;61;61;61;62 19:00:10 INFO - PROCESS | 8983 | |10;stanford-crypto-aes;89;81;81;80;88;85;80;80;80;80 19:00:10 INFO - PROCESS | 8983 | |11;stanford-crypto-ccm;145;132;131;151;161;135;148;136;182;128 19:00:10 INFO - PROCESS | 8983 | |12;stanford-crypto-pbkdf2;165;169;166;167;166;164;170;165;163;164 19:00:10 INFO - PROCESS | 8983 | |13;stanford-crypto-sha256-iterative;66;67;67;65;69;65;66;65;65;65 19:00:10 INFO - PROCESS | 8983 | __end_tp_report 19:00:10 INFO - PROCESS | 8983 | __start_cc_report 19:00:10 INFO - PROCESS | 8983 | _x_x_mozilla_cycle_collect,801 19:00:10 INFO - PROCESS | 8983 | __end_cc_report 19:00:10 INFO - PROCESS | 8983 | __startTimestamp1476324010729__endTimestamp 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | ------- Summary: start ------- 19:00:10 INFO - PROCESS | 8983 | Number of tests: 14 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.50 stddev:2.15 (1.9%) stddev-sans-first:1.66 19:00:10 INFO - PROCESS | 8983 | Values: 107.0 115.0 113.0 112.0 111.0 111.0 112.0 111.0 109.0 111.0 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:128.00 stddev:17.97 (14.0%) stddev-sans-first:17.48 19:00:10 INFO - PROCESS | 8983 | Values: 157.0 129.0 127.0 173.0 126.0 124.0 126.0 125.0 155.0 124.0 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:3.43 (2.1%) stddev-sans-first:3.61 19:00:10 INFO - PROCESS | 8983 | Values: 165.0 162.0 164.0 173.0 163.0 163.0 162.0 163.0 161.0 162.0 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:12.38 (16.3%) stddev-sans-first:12.97 19:00:10 INFO - PROCESS | 8983 | Values: 76.0 76.0 76.0 107.0 77.0 75.0 76.0 75.0 103.0 75.0 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:83.00 stddev:13.01 (15.7%) stddev-sans-first:13.46 19:00:10 INFO - PROCESS | 8983 | Values: 83.0 84.0 110.0 83.0 83.0 83.0 108.0 83.0 83.0 112.0 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 19:00:10 INFO - PROCESS | 8983 | Values: 118.0 117.0 118.0 118.0 117.0 118.0 117.0 118.0 118.0 119.0 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 19:00:10 INFO - PROCESS | 8983 | Values: 146.0 149.0 147.0 147.0 147.0 148.0 148.0 147.0 147.0 147.0 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:97.00 stddev:2.18 (2.3%) stddev-sans-first:2.28 19:00:10 INFO - PROCESS | 8983 | Values: 96.0 97.0 96.0 97.0 97.0 96.0 103.0 97.0 97.0 95.0 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:57.00 stddev:2.05 (3.6%) stddev-sans-first:2.05 19:00:10 INFO - PROCESS | 8983 | Values: 54.0 54.0 58.0 59.0 54.0 56.0 58.0 55.0 54.0 58.0 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 19:00:10 INFO - PROCESS | 8983 | Values: 61.0 62.0 62.0 62.0 62.0 61.0 61.0 61.0 61.0 62.0 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:81.00 stddev:3.57 (4.4%) stddev-sans-first:2.87 19:00:10 INFO - PROCESS | 8983 | Values: 89.0 81.0 81.0 80.0 88.0 85.0 80.0 80.0 80.0 80.0 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:146.50 stddev:16.68 (11.4%) stddev-sans-first:17.69 19:00:10 INFO - PROCESS | 8983 | Values: 145.0 132.0 131.0 151.0 161.0 135.0 148.0 136.0 182.0 128.0 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:166.00 stddev:2.23 (1.3%) stddev-sans-first:2.35 19:00:10 INFO - PROCESS | 8983 | Values: 165.0 169.0 166.0 167.0 166.0 164.0 170.0 165.0 163.0 164.0 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.33 (2.0%) stddev-sans-first:1.41 19:00:10 INFO - PROCESS | 8983 | Values: 66.0 67.0 67.0 65.0 69.0 65.0 66.0 65.0 65.0 65.0 19:00:10 INFO - PROCESS | 8983 | -------- Summary: end -------- 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | 19:00:10 INFO - PROCESS | 8983 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 19:00:10 INFO - PROCESS | 8983 | 19:00:11 INFO - TEST-INFO | 8983: exit 0 19:00:11 INFO - TEST-OK | kraken | took 63142ms 19:00:11 INFO - SUITE-END | took 1178s 19:00:12 INFO - Completed test suite (00:19:38) 19:00:12 INFO - javascript benchmark 19:00:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7174.704198630076, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3027.636683597968, 3048.893288734894, 3055.893043743468, 3056.8318742469155, 3109.9067027989154, 5228.294180285669, 5304.230886521457, 5384.2731231283815, 5390.245365648808, 5452.59105567083, 5283.894322113555, 5292.523672869441, 5386.326709161355, 5416.756245968931, 5485.588580856432, 4855.854324370274, 4877.853664390056, 4896.094222568819, 4940.678855874375, 4961.900761984758, 4737.692050016755, 4877.780499877496, 4937.629677774164, 4942.53045960635, 4971.229459433794, 4761.190597598382, 4807.807687692488, 4810.6873053251775, 4855.805767769285, 4858.659893807435, 4785.904281914377, 4838.395200599925, 4865.19724245499, 4912.631552633531, 4921.434035085939, 4824.421069471686, 4833.685810422347, 4837.032593481283, 4851.199552073939, 4868.02639472107, 5125.974370128126, 5212.609054320941, 5219.0, 5273.129933560957, 5344.599155063386, 5729.455701708331, 5783.768649254025, 5805.796797112123, 5838.5329173666005, 5880.882382352372, 5864.472197502203, 5875.823725288205, 5879.441453061952, 5885.823425297248, 5886.764529418818, 5110.514501122388, 5439.510444060014, 5453.263809385761, 5456.372517160498, 5465.234867118606, 5585.664860108406, 5721.170430287585, 5756.079027355603, 5778.479936805707, 5879.970600146972, 5566.081596536526, 5568.276124103841, 5570.693611851306, 5578.944210557924, 5580.386157522669, 5574.749136288877, 5614.943850561442, 5627.155926610959, 5672.120821272627, 5687.175359572839, 5611.466910643482, 5620.831375058755, 5672.12082127271, 5674.659520428788, 5685.459881311269, 5518.089515230023, 5610.102383618601, 5630.07103827872, 5634.352049514358, 5638.464345887134, 4288.50682171548, 4306.2894622387585, 4315.274774122331, 4320.567943205654, 4355.368471571668, 3759.172981943968, 3808.333541630204, 3841.8666493384517, 3860.1121741999495, 3870.670992965573, 5368.409474957752, 5433.701146436905, 5436.293281873332, 5471.945280547223, 5526.50261476469, 5702.087665973424, 5737.397573254748, 5740.1102829061565, 5785.247917770663, 5813.215215945793, 5324.227986941872, 5382.569394448435, 5432.6468779529205, 5436.281859070465, 5496.450354964471, 4965.131102057126, 4974.552290293818, 4991.376077990251, 5014.623903207274, 5024.296598476216, 5970.5223582114195, 6017.548683848729, 6018.518518518508, 6020.939790602126, 6025.698715064317, 5438.0, 5520.723963801714, 5526.419725928719, 5842.678652673973, 5867.501262392744, 5725.341585717696, 5781.392953739965, 5797.159411885169, 5849.298084229919, 5863.794767183128, 5483.780648774164, 5487.176923461513, 5488.396276409512, 5507.862303442446, 5534.142207957773, 5612.915806262828, 5614.21401003868, 5650.971745141248, 5654.491095801398, 5670.489655930986, 5558.194061860927, 5614.157876318585, 5648.830535083954, 5687.20379146928, 5752.395998420106, 5699.23060386859, 5707.942920570741, 5713.542916566582, 5714.514266287412, 5737.225474560881, 5388.164834450667, 5450.809221677222, 5465.836024919259, 5606.523445507178, 5620.100783874561, 5663.4053424391495, 5723.02708539541, 5745.0, 5801.477866991822, 5803.361630220588, 5566.805161819317, 5595.608307418442, 5609.607327487037, 5613.073842815889, 5618.185363122406], "value": 5266.4904124114655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.7145263094769, 582.9038208695565, 588.496835205899, 597.9714890388532, 619.1641284266238, 38704.419433708485, 42403.78798106013, 42460.15079698404, 42543.0, 42548.36177457333, 42139.57860421395, 42679.35980960288, 42823.5011774588, 42827.5010374637, 42924.356134658, 8808.779780505474, 8930.419522731001, 8954.417962832395, 8956.373053886231, 8980.955095224515, 8782.253508451757, 8785.912140878605, 8794.912050879506, 8827.823443531126, 8829.867551986725, 8836.204741573258, 8923.10768923109, 8936.285097192242, 8940.687075952343, 8954.059823718513, 8856.070112638177, 8879.200871921557, 8885.333599980027, 8891.422057566237, 8898.510581917992, 8707.738767836974, 8796.692115775917, 8811.118888111201, 8837.513936733478, 8839.558022098934, 40253.79873100616, 40267.798661006804, 40359.59640403617, 40452.797736011424, 40586.0, 3348.96651033489, 3373.595168579762, 3431.5367425397753, 3460.8961731148106, 3482.460218666111, 31161.94034299801, 32028.519572206435, 32105.1973700657, 32648.6735132648, 33312.666873331444, 4172.207280616703, 4249.681273904439, 4362.694611377205, 4373.737575745466, 4402.449693788277, 334264.0, 337294.31352843327, 338413.0, 338641.0, 341642.0, 58182.0, 58836.411635883094, 58871.112888710784, 58937.41062589405, 59010.40989590135, 61591.69204153951, 61793.0, 62112.0, 62313.376866231665, 62577.37422625806, 14858.777118343234, 15068.698626027419, 15169.317380717894, 15182.46861359847, 15211.847881521264, 11471.426428678533, 11498.0, 11525.366104864146, 11540.076793856471, 11555.653330400102, 16632.83367166337, 17446.912765436093, 17481.300747970192, 17519.124043797758, 17566.91216543909, 6011.6693581853415, 6102.877942441126, 6268.968655156695, 6292.653904035231, 6310.968445157745, 873.9344549158839, 965.3347974743511, 979.857920601523, 990.2573070197352, 1038.1850247555633, 31550.684493154775, 31760.841195793873, 31801.0, 31948.94190111201, 32412.0, 1041.7551875309296, 1046.8115739166872, 1061.400308825511, 1067.215596536545, 1110.5835311758092, 15588.92205538965, 16484.763991236854, 16508.0, 16748.330066797193, 16836.494905152864, 463015.0, 464930.0, 465323.0, 466607.0, 469716.0, 57729.71135144382, 57796.711016445486, 57896.42103578994, 57960.30595410638, 58102.70948645314, 1264.9810252846214, 1267.847858257015, 1313.1661395014044, 1314.9342532873318, 1325.870944570812, 29664.0, 30376.734832041984, 31665.366692665557, 31697.683023169473, 32444.35111297808, 50464.49535504598, 51348.48651513437, 51393.743031284605, 51400.48599514107, 51567.226491601905, 407420.0, 408240.0, 408808.0, 409852.0, 410825.0, 40190.583800377295, 40229.39655905105, 40533.59466405416, 40844.0, 41440.79279603583, 46667.0, 46981.295280570135, 48159.75920120377, 48399.5160048395, 48458.0616775325, 38469.4229586562, 38949.0, 39553.604463954995, 40920.38619420651, 41025.589744103374, 38138.61861381351, 39137.41293880537, 39427.80286098551, 39660.60339396685, 40644.796776017116, 39530.60469395269, 40392.39411408772, 41572.58427415687, 41662.791686041375, 41665.79167104145, 30938.690613093582, 34463.65536344604, 35634.82182589071, 36234.0, 37019.0, 26964.303569642878, 27831.30421739473, 27954.440911182068, 28004.29989250285, 28308.06125252863], "value": 19679.804201219213, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.4936932618272, 391.70426328122284, 403.2479425870751, 404.13515077733643, 418.2617679795162, 17501.56246093847, 18315.816841831576, 18897.14962826676, 18993.0, 19075.236990520396, 18035.188416521254, 18252.817471825278, 18253.634927301446, 18284.268629254846, 18335.908320458413, 5536.446355364452, 5538.0, 5792.6524408535415, 5796.623219490741, 5802.767889284445, 5832.766689332421, 5867.501262392701, 5878.177055212273, 5888.440598143169, 5895.174675545427, 5746.597738158331, 5871.618344807595, 6252.812415627538, 6298.559100862942, 6349.61902285862, 5954.570902983296, 6212.502999760009, 6233.71948262327, 6267.43593076623, 6268.561200715952, 5614.157876318544, 5686.3744988051285, 5691.089425691869, 5691.516221121168, 5710.914336284959, 21043.0, 21285.893570532204, 21291.14835406582, 21735.0, 21919.12323507058, 2084.343431818972, 2160.6002889465344, 2343.086196383412, 2362.9527409451885, 2455.1652438170927, 9778.022197780236, 9910.562968369546, 10183.694489165337, 10314.587416503331, 10682.412467314294, 1879.3985924504163, 1935.3032908153054, 1969.1827891425041, 1992.7708313543983, 2024.8886311252875, 71691.92462113072, 77180.61409692971, 78949.60525197338, 78958.60520697417, 80349.2664505396, 10716.839247411295, 10869.456527173768, 11055.502502387251, 11137.832932505857, 11244.550217991353, 15343.619074283368, 15387.307571159325, 15453.0, 15482.690346193012, 15508.689826203412, 7562.962185189039, 7747.806304842424, 7797.727079552188, 7934.2859142677435, 7959.164287749819, 7182.676779544933, 7210.603416812126, 7221.169565499929, 7442.95318787327, 7452.515586486861, 4607.470140933769, 4623.838165664186, 4719.126961512131, 4732.929006064912, 4778.307145463888, 1954.208545539059, 1956.628240634275, 2007.1569940624972, 2044.6524090904284, 2071.596038772425, 804.3605333759558, 826.8801023851507, 861.2291998661289, 899.8425275576878, 935.036911980661, 16523.586910327336, 17308.307667693152, 17997.820021799875, 18104.185311661007, 18752.62494750125, 920.4569304110607, 937.6202637931649, 947.0434860790651, 947.8009617980301, 976.2824324121765, 9530.475823829756, 10158.39049657023, 10265.538050787583, 10295.845562316572, 10340.689779306633, 400744.0, 401949.0, 408326.0, 416171.0, 423766.0, 82207.17792821996, 86006.0, 86532.0, 90048.95104895104, 93855.53072234595, 1014.0923873133504, 1039.3555995282973, 1063.0591926145262, 1066.9786604267872, 1068.6687126990657, 16235.675286494441, 16414.425495107615, 16874.240659170122, 17028.659426811148, 17109.82890171132, 39031.609683902796, 39291.80354098326, 40501.39247911225, 40552.0, 41874.79062604668, 53024.73487632537, 53952.46047539474, 57624.423755761905, 57908.0, 58981.11528326993, 7300.415966722543, 7577.659005344883, 7792.415568832474, 7887.526748395115, 8114.878276825734, 9519.048095190425, 12385.876141238472, 12518.874811251771, 12827.679308017374, 12832.55086071983, 11197.496112675111, 11390.544378224778, 11411.25826821254, 11642.476088576204, 11817.231879927776, 11060.446977651247, 11102.555897764321, 11251.0, 11340.376279304717, 11641.0, 11089.667309980714, 11112.22214444981, 11244.493997769956, 11250.831237531607, 12063.155579109378, 7763.650635721293, 7959.801004974922, 7978.281954624112, 7984.840303193788, 8244.628991695508, 9799.363041402286, 11149.0, 11228.719282017688, 11376.94311528437, 11386.146039046938], "value": 8930.111637181568, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.405551696046, 1479.9936043490425, 1587.745960646296, 1681.5964168599523, 1691.2220378625832, 7780.299773020427, 7998.240167184108, 8937.10628937106, 9469.621215151394, 9471.81056378873, 8734.737957861274, 9081.137291957253, 9091.909080909189, 9362.765930851732, 9382.765430864232, 2322.268485427089, 2359.905603775847, 2359.9646005309933, 2361.4332560185603, 2366.9763302367014, 2324.2562380038394, 2332.125452955142, 2339.883005849709, 2347.4600841806396, 2357.1867705641525, 2339.5671800716923, 2341.7892389684926, 2363.444590521226, 2364.3498038039506, 2369.6445533170076, 2279.726432828071, 2299.9540009199804, 2308.3421224950894, 2317.3627252505694, 2318.431984163882, 2276.5105502317083, 2282.931512054641, 2284.3946354216146, 2288.7711228877147, 2320.8491448055993, 9136.725898223063, 9257.814843703156, 9262.907370926272, 9371.34400591959, 9386.108319709616, 5265.0, 5417.0, 5417.404085550586, 5422.8915421691345, 5430.5927055471, 3323.8670453181844, 3328.5506456628286, 3530.7881527108457, 3535.222251104753, 3536.381133301662, 1044.383941765374, 1084.7613525024483, 1114.7826173896094, 1119.5353928119903, 1132.2357408749062, 12996.675083122998, 13076.542321018718, 13076.542321018815, 13087.86912130876, 13245.86754132456, 4554.4990051094355, 4728.101660684459, 4829.227323628203, 4837.540433658797, 4851.51484851512, 10974.835377469344, 10975.0, 11037.39294338803, 11038.834417483744, 11042.834357484644, 5421.512063914267, 5428.104362780097, 5466.9179962300595, 5484.0, 5519.779208831682, 4331.177076355482, 4447.577480139446, 4779.856604301807, 4988.5260900214425, 4996.175631020914, 3933.3116704576582, 3977.423273625308, 4020.5175378954714, 4071.3485842265686, 4124.4019617155345, 1270.7394984028251, 1291.289790615158, 1293.489071816627, 1294.7539967406162, 1296.5786119511008, 724.9166345870292, 858.5321000054985, 874.4010352908278, 880.9383343165916, 898.7169041751828, 5374.54316383104, 5404.83785486436, 5405.891882162335, 5421.647592906448, 5454.863628409322, 433.5058033841423, 442.1488634378808, 444.4244703109481, 446.2703479810468, 451.3568165364343, 3543.291341731664, 3552.2717842842158, 3650.5071815305123, 3653.214558869856, 3705.110773414361, 11117.332960022424, 11450.599229026944, 11549.076073914066, 11638.41807909601, 11654.76690466186, 11528.308301501937, 11577.247478913843, 11578.536858525564, 11643.41782910851, 11674.824877626843, 8444.692092616038, 8513.616887240089, 8567.400281980326, 8625.0943650917, 8672.132786721404, 5144.6913185209005, 5208.739563021758, 5273.393559740679, 5290.100682883996, 5307.9734601326745, 10258.820235672694, 10480.10919071857, 10498.107660848913, 10509.316894402145, 10635.042846143884, 10473.68578942633, 10985.0, 10985.945070274598, 11002.119830413707, 11098.778024439305, 8203.671853126047, 8214.917850821415, 8245.257926786378, 8315.12691167443, 8338.66645334204, 8935.106489351012, 8978.730638080868, 9037.864432033657, 9039.774005649911, 9045.638174472948, 7886.369090472634, 7931.286184243446, 7995.880061798961, 8169.959150204211, 8397.286230670217, 7916.525008499509, 7937.960310198412, 7997.960010199912, 8106.918930810616, 8157.510549367057, 6958.130233720785, 7289.671964761705, 7368.1526624438875, 7390.408767298496, 7412.147603025721, 4897.608191344612, 4898.951010489849, 4905.730184839868, 5023.773930173078, 5117.948820511747, 4933.703977761345, 4971.279164521196, 4972.055309491185, 5038.974805126098, 5041.6722913010535], "value": 4588.2584971526485, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.8927853808242, 332.9317489914567, 335.1955307262571, 338.1883479648843, 341.39743352981975, 5380.596455265861, 5484.451554844523, 5590.524805391541, 5628.409017053212, 5676.347220069693, 5356.491133342336, 5476.67139971601, 5481.479259470354, 5527.861803454915, 5535.557155427567, 4346.21768081746, 4350.825966961318, 4354.0, 4367.519572846984, 4368.475782906055, 4216.367544868279, 4286.892827679318, 4324.481062272532, 4351.6953813233085, 4376.649868010568, 4281.935770963422, 4284.764337961411, 4289.613934745872, 4295.312749960007, 4302.849400270991, 4262.9147417051645, 4283.336082907154, 4289.206496798102, 4302.096559722462, 4321.459817522809, 3712.832922518493, 3832.4442955771256, 3836.48458858752, 3850.152966347399, 3869.8452061917487, 5310.0441920454305, 5335.946640533583, 5348.277982472394, 5355.384130824966, 5361.356637203521, 4844.878878028042, 4861.659683822134, 4877.756112194376, 4880.877978050542, 4933.136701077333, 5509.559235261169, 5614.466625670596, 5635.098384258499, 5672.5178359839465, 5691.0, 4089.4683691120263, 4103.179364127186, 4110.403991421227, 4113.095119073799, 4129.009037830929, 5865.35481097079, 5894.3810899855325, 5899.439553242435, 5917.319508256563, 5917.349091599964, 4179.6029377209115, 4218.683598730107, 4278.9088782360295, 4282.550332215135, 4308.590683885026, 4284.571542845691, 4319.762413067311, 4337.65766486094, 4354.673399495051, 4357.106793107406, 4891.461939186686, 4891.486393928657, 4898.779554920037, 4905.632077594195, 4938.0, 5544.251526043932, 5717.371089180187, 5726.455986681259, 5746.367899531048, 5765.625234359753, 1478.8447213042691, 1482.7331080405631, 1494.4022391043452, 1494.8355680875095, 1499.8500149985132, 928.9303302252358, 957.2198658093631, 957.6025949231131, 964.1515466389533, 977.0180968126987, 4817.710937343701, 4883.389576302962, 4890.263956295535, 4906.92639610399, 4979.950200497949, 5168.3539557555305, 5217.165253559412, 5230.169440695726, 5234.691327168208, 5283.233931079972, 4619.538046195421, 4817.759112044454, 4960.603151747851, 4963.677360971526, 4967.5777558907175, 2760.4617099665775, 2764.5023895698564, 2786.944261114807, 2789.17719272815, 2839.8640543782653, 5353.9732301338245, 5370.355557333145, 5390.628123625592, 5434.402215756264, 5464.934337804169, 5244.898571299994, 5263.131583288791, 5753.280839895013, 6102.633841969496, 6121.326654068049, 6157.9384206158265, 6157.96921015401, 6159.692015399212, 6168.383161683885, 6206.286277078104, 5626.803061892814, 5957.553183511341, 5957.672328022, 5972.522198224218, 5992.262243949206, 5859.619124756877, 5861.062230043172, 5866.735996880066, 5882.941170588239, 5887.322957859729, 6093.146959425595, 6159.72281247336, 6166.876662466815, 6168.568200225941, 6201.10084037803, 3930.7248492605245, 3941.7240793144206, 4162.958370416257, 4181.330987042059, 4198.160367926488, 5909.2908850938165, 5913.852153696192, 5914.290285165635, 5966.224390829165, 6030.758769649165, 5774.372660439406, 5792.94207057924, 5904.822855314347, 5914.142449344735, 5918.461200087922, 5702.857428564153, 5733.971330143323, 5750.798722044876, 5753.913691294718, 5765.135229715408, 5653.802116925888, 5710.457506536873, 5727.5417966561745, 5735.799247026334, 5803.9419605803405, 5645.830625081254, 5742.19609254713, 5774.440900956634, 5808.82573522795, 5817.680027598522, 5654.123610840326, 5660.632058916157, 5663.801766938137, 5672.744726487235, 5681.744321505625], "value": 4320.253924418708, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.2191145916573, 717.6591119218372, 725.3798002707681, 740.1451323721101, 790.083503136362, 15531.378744850206, 16590.170491475437, 16599.419020334277, 16625.667486650258, 16634.916825415872, 14923.477678281262, 14968.401263949429, 14971.401143954256, 15101.546953591409, 15113.244337783095, 782.4131901074209, 792.2592376128339, 792.3581898662073, 792.6750032486682, 792.7066985215479, 809.0372456776417, 815.6859609050499, 820.1593366799019, 821.7822277096544, 822.5475988206492, 855.5935930433056, 859.9852174434166, 860.290260535058, 861.3668953319306, 862.9482231066124, 842.7176895739934, 849.8045449546577, 850.587465079436, 851.0978362935277, 852.4544291653347, 616.9691515424256, 618.7153909201772, 619.071392910634, 622.0265284829228, 624.073251221935, 15900.125493097876, 16149.0, 16166.0, 16171.676566468605, 16188.676226475405, 14390.71218575633, 14412.855871441256, 14429.49496767608, 14432.27838608076, 14571.344289506998, 11839.230450020807, 11934.403279835973, 12005.87994120065, 12206.328651924141, 12792.616221513277, 3809.4476300936485, 3834.7699138051526, 3922.627350401736, 3999.42008408782, 4009.158076803875, 81385.59307203426, 83564.58217708934, 84182.0, 84283.57858210731, 84759.0, 10614.310069845435, 10791.676249712522, 10814.891851081546, 10927.0, 11027.338359698284, 21553.461163471038, 21635.459113521974, 21666.674999875013, 21692.0, 21744.78255217459, 8253.463524870864, 8268.875966860502, 8772.517511536927, 8782.253508451726, 8802.515861627671, 4278.44380230568, 4324.545922678137, 4377.387165796791, 4437.068215674744, 4580.748058856728, 3548.591911930161, 3651.3610118229203, 3682.226732386229, 3684.9263014739554, 3689.3728066228805, 587.6386022596158, 596.9611975221596, 603.6981509245377, 616.442119881508, 624.2228425610144, 491.50112635674816, 524.8950209957948, 532.6351449257194, 619.9349068347849, 696.7247937064831, 9560.176069151514, 9583.329166958247, 9701.660441884642, 9758.853617195748, 9837.262205334628, 582.8134996801068, 600.2287061126432, 675.8006388115517, 678.5792808458689, 711.3100292716057, 4317.120855444263, 4482.386340917267, 4622.976885115553, 4805.8558243252755, 4868.14807408702, 103737.0, 118373.0, 121250.39374803069, 122390.0, 124954.0, 110505.44747276213, 111061.0, 112525.43737281261, 114132.0, 114660.0, 61508.0, 91285.54357228172, 91396.5430172845, 92076.0, 97483.0, 9053.321000924825, 9099.954500227457, 9323.953380233055, 9325.533723313943, 9349.158575728217, 52725.78193744568, 52800.47199527956, 52835.735821320646, 53937.0, 55772.442275578345, 69756.0, 78458.6077069611, 79951.60024199841, 81408.0, 83050.16949830424, 11467.483963221508, 11489.138314626269, 11522.76954460923, 11640.649952091835, 11863.288202707865, 12471.688207794878, 12929.224246545238, 13167.934160329138, 13394.129381590166, 13553.525626603021, 12440.0, 12534.937325313314, 12822.743545129231, 12954.093213475344, 13600.591982240549, 11920.880791192323, 12052.819207712068, 12066.577669781516, 12468.501259949864, 12865.549705760253, 11351.318920864775, 12272.140950133406, 12356.814647780111, 13102.803457947948, 13539.323033848465, 9615.423074615546, 9791.363561368487, 9854.310198286052, 9888.456134912649, 9968.900310997087, 10355.94822025885, 10787.568497260021, 10829.945850271013, 10963.0, 11037.0], "value": 7434.030351016333, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 113.0, 112.0, 111.0, 111.0, 112.0, 111.0, 109.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 129.0, 127.0, 173.0, 126.0, 124.0, 126.0, 125.0, 155.0, 124.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 164.0, 173.0, 163.0, 163.0, 162.0, 163.0, 161.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 107.0, 77.0, 75.0, 76.0, 75.0, 103.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 110.0, 83.0, 83.0, 83.0, 108.0, 83.0, 83.0, 112.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 119.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 103.0, 97.0, 97.0, 95.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 58.0, 59.0, 54.0, 56.0, 58.0, 55.0, 54.0, 58.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 81.0, 81.0, 80.0, 88.0, 85.0, 80.0, 80.0, 80.0, 80.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 132.0, 131.0, 151.0, 161.0, 135.0, 148.0, 136.0, 182.0, 128.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 169.0, 166.0, 167.0, 166.0, 164.0, 170.0, 165.0, 163.0, 164.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 65.0, 69.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 66.0, "unit": "score"}]}]} 19:00:12 INFO - Return code: 0 19:00:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:00:12 ERROR - # TBPL SUCCESS # 19:00:12 INFO - Running post-action listener: _resource_record_post_action 19:00:12 INFO - [mozharness: 2016-10-13 02:00:12.517663Z] Finished run-tests step (success) 19:00:12 INFO - Running post-run listener: _resource_record_post_run 19:00:12 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 407691264; Read time: 0; Write time: 312384 19:00:12 INFO - TinderboxPrint: CPU usage
13.4% 19:00:12 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:00:12 INFO - TinderboxPrint: I/O write bytes / time
407,691,264 / 312,384 19:00:12 INFO - TinderboxPrint: CPU idle
8,260.5 (86.6%) 19:00:12 INFO - TinderboxPrint: CPU user
1,212.7 (12.7%) 19:00:12 INFO - TinderboxPrint: Swap in / out
0 / 0 19:00:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118034432; Read time: 0; Write time: 98424 19:00:12 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289656832; Read time: 0; Write time: 213960 19:00:13 INFO - Running post-run listener: _upload_blobber_files 19:00:13 INFO - Blob upload gear active. 19:00:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:00: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 19:00: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'] 19:00: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 19:00:13 INFO - (blobuploader) - INFO - Open directory for files ... 19:00:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:00:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:00:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:14 INFO - (blobuploader) - INFO - Done attempting. 19:00:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:00:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:00:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:15 INFO - (blobuploader) - INFO - Done attempting. 19:00:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:00:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:00:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:18 INFO - (blobuploader) - INFO - Done attempting. 19:00:18 INFO - (blobuploader) - INFO - Iteration through files over. 19:00:18 INFO - Return code: 0 19:00:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:00:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:00:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/584bb95e57e93f5c74375ffa0d0ee03bcdf22fb5d0c0c44b144d4b359539f21c77c6492d87c310412f4b1ca004a8cdd072798527b2c082bf18e8b3ede193f3b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b546ddab6100efdaf66e00d5f11bc105c486b691e98809e754fdeefabab98accf07e01914a1c8adc0819ba55d462260fbbb08d8eaea0ff2535cc1c3ffa54e39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb575f54690c3ad8dc93305119247ba12ab5541efeac6303ebd14768109aa43ada317a5193d74f7a5321ba1f4c34644ddaa8c5f35ab1a34cc53b284d2058be38"} 19:00:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:00:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:00:18 INFO - Contents: 19:00:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/584bb95e57e93f5c74375ffa0d0ee03bcdf22fb5d0c0c44b144d4b359539f21c77c6492d87c310412f4b1ca004a8cdd072798527b2c082bf18e8b3ede193f3b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b546ddab6100efdaf66e00d5f11bc105c486b691e98809e754fdeefabab98accf07e01914a1c8adc0819ba55d462260fbbb08d8eaea0ff2535cc1c3ffa54e39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb575f54690c3ad8dc93305119247ba12ab5541efeac6303ebd14768109aa43ada317a5193d74f7a5321ba1f4c34644ddaa8c5f35ab1a34cc53b284d2058be38"} 19:00:18 INFO - Running post-run listener: copy_logs_to_upload_dir 19:00:18 INFO - Copying logs to upload dir... 19:00:18 INFO - mkdir: /builds/slave/test/build/upload/logs 19:00:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.763240 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-10-12 19:00:17.750243) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 19:00:17.754065) ========= 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=db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/584bb95e57e93f5c74375ffa0d0ee03bcdf22fb5d0c0c44b144d4b359539f21c77c6492d87c310412f4b1ca004a8cdd072798527b2c082bf18e8b3ede193f3b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b546ddab6100efdaf66e00d5f11bc105c486b691e98809e754fdeefabab98accf07e01914a1c8adc0819ba55d462260fbbb08d8eaea0ff2535cc1c3ffa54e39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb575f54690c3ad8dc93305119247ba12ab5541efeac6303ebd14768109aa43ada317a5193d74f7a5321ba1f4c34644ddaa8c5f35ab1a34cc53b284d2058be38"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476311401/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/584bb95e57e93f5c74375ffa0d0ee03bcdf22fb5d0c0c44b144d4b359539f21c77c6492d87c310412f4b1ca004a8cdd072798527b2c082bf18e8b3ede193f3b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b546ddab6100efdaf66e00d5f11bc105c486b691e98809e754fdeefabab98accf07e01914a1c8adc0819ba55d462260fbbb08d8eaea0ff2535cc1c3ffa54e39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb575f54690c3ad8dc93305119247ba12ab5541efeac6303ebd14768109aa43ada317a5193d74f7a5321ba1f4c34644ddaa8c5f35ab1a34cc53b284d2058be38"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 19:00:17.782035) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 19:00:17.782351) ========= 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=db7e7c15f3ca076d53731445000001ba-1476322780.673512-310721037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 19:00:17.865479) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 19:00:17.865795) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 19:00:17.866099) ========= ========= Total master_lag: 0.16 =========