builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1465810706.88 results: success (0) buildid: 20160613013726 builduid: e10494be4997461cae7fdc4dd510588d revision: 405bdbc110e121282d453fcf66cbf0daa8c3441e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:26.880130) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:26.880547) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:26.880854) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:26.936139) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:26.936617) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-13 02:38:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-06-13 02:38:27 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.198361 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:27.184106) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:27.184423) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.132776 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:27.329685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:27.330104) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 405bdbc110e121282d453fcf66cbf0daa8c3441e --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 405bdbc110e121282d453fcf66cbf0daa8c3441e --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=d6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-13 02:38:27,493 truncating revision to first 12 chars 2016-06-13 02:38:27,493 Setting DEBUG logging. 2016-06-13 02:38:27,494 attempt 1/10 2016-06-13 02:38:27,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/405bdbc110e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-13 02:38:27,810 unpacking tar archive at: fx-team-405bdbc110e1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656184 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:27.998874) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:27.999152) ========= script_repo_revision: 405bdbc110e121282d453fcf66cbf0daa8c3441e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:27.999521) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:27.999786) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 02:38:28.008785) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-06-13 02:38:28.009070) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=d6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:38:28 INFO - MultiFileLogger online at 20160613 02:38:28 in /builds/slave/test 02:38:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:38:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:38:28 INFO - {'append_to_log': False, 02:38:28 INFO - 'base_work_dir': '/builds/slave/test', 02:38:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:38:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:38:28 INFO - 'branch': 'Fx-Team-Non-PGO', 02:38:28 INFO - 'buildbot_json_path': 'buildprops.json', 02:38:28 INFO - 'config_files': ('talos/linux_config.py',), 02:38:28 INFO - 'default_actions': ('clobber', 02:38:28 INFO - 'read-buildbot-config', 02:38:28 INFO - 'download-and-extract', 02:38:28 INFO - 'populate-webroot', 02:38:28 INFO - 'create-virtualenv', 02:38:28 INFO - 'install', 02:38:28 INFO - 'run-tests'), 02:38:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:38:28 INFO - 'download_minidump_stackwalk': True, 02:38:28 INFO - 'download_symbols': 'ondemand', 02:38:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:38:28 INFO - 'tooltool.py': '/tools/tooltool.py', 02:38:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:38:28 INFO - '/tools/misc-python/virtualenv.py')}, 02:38:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:38:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:38:28 INFO - 'installer_path': 'installer.exe', 02:38:28 INFO - 'log_level': 'info', 02:38:28 INFO - 'log_name': 'talos', 02:38:28 INFO - 'log_to_console': True, 02:38:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:38:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:38:28 INFO - 'opt_config_files': (), 02:38:28 INFO - 'pip_index': False, 02:38:28 INFO - 'sps_profile': False, 02:38:28 INFO - 'sps_profile_interval': 0, 02:38:28 INFO - 'suite': 'dromaeojs-e10s', 02:38:28 INFO - 'system_bits': '32', 02:38:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:38:28 INFO - 'title': 'talos-linux64-ix-034', 02:38:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:38:28 INFO - 'use_talos_json': True, 02:38:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:38:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:38:28 INFO - 'work_dir': 'build'} 02:38:28 INFO - ##### 02:38:28 INFO - ##### Running clobber step. 02:38:28 INFO - ##### 02:38:28 INFO - Running pre-action listener: _resource_record_pre_action 02:38:28 INFO - Running main action method: clobber 02:38:28 INFO - rmtree: /builds/slave/test/build 02:38:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:38:29 INFO - Running post-action listener: _resource_record_post_action 02:38:29 INFO - ##### 02:38:29 INFO - ##### Finished clobber step (success) 02:38:29 INFO - ##### 02:38:29 INFO - ##### 02:38:29 INFO - ##### Running read-buildbot-config step. 02:38:29 INFO - ##### 02:38:29 INFO - Running pre-action listener: _resource_record_pre_action 02:38:29 INFO - Running main action method: read_buildbot_config 02:38:29 INFO - Using buildbot properties: 02:38:29 INFO - { 02:38:29 INFO - "project": "", 02:38:29 INFO - "product": "firefox", 02:38:29 INFO - "script_repo_revision": "production", 02:38:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:38:29 INFO - "repository": "", 02:38:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:38:29 INFO - "buildid": "20160613013726", 02:38:29 INFO - "pgo_build": "False", 02:38:29 INFO - "basedir": "/builds/slave/test", 02:38:29 INFO - "buildnumber": 1406, 02:38:29 INFO - "slavename": "talos-linux64-ix-034", 02:38:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:38:29 INFO - "platform": "ubuntu64_hw", 02:38:29 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:38:29 INFO - "branch": "fx-team", 02:38:29 INFO - "repo_path": "integration/fx-team", 02:38:29 INFO - "revision": "405bdbc110e121282d453fcf66cbf0daa8c3441e", 02:38:29 INFO - "stage_platform": "linux64", 02:38:29 INFO - "builduid": "e10494be4997461cae7fdc4dd510588d", 02:38:29 INFO - "slavebuilddir": "test" 02:38:29 INFO - } 02:38:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:38:29 INFO - Running post-action listener: _resource_record_post_action 02:38:29 INFO - ##### 02:38:29 INFO - ##### Finished read-buildbot-config step (success) 02:38:29 INFO - ##### 02:38:29 INFO - ##### 02:38:29 INFO - ##### Running download-and-extract step. 02:38:29 INFO - ##### 02:38:29 INFO - Running pre-action listener: _resource_record_pre_action 02:38:29 INFO - Running main action method: download_and_extract 02:38:29 INFO - mkdir: /builds/slave/test/build/tests 02:38:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:29 INFO - https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:38:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:38:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:38:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:38:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:38:32 INFO - Downloaded 1361 bytes. 02:38:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:38:32 INFO - Using the following test package requirements: 02:38:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:38:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:38:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:38:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:32 INFO - u'jsshell-linux-x86_64.zip'], 02:38:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:38:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:38:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:38:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:38:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:38:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:38:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:38:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:32 INFO - https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:38:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:38:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:38:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:38:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:38:33 INFO - Downloaded 22651503 bytes. 02:38:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:38:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:38:35 INFO - Return code: 0 02:38:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:38:35 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:35 INFO - https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:38:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:38:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:38:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:38:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:38:52 INFO - Downloaded 22651503 bytes. 02:38:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:38:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:38:54 INFO - Return code: 0 02:38:54 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:54 INFO - https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:38:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:38:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:38:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:38:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:38:58 INFO - Downloaded 14405384 bytes. 02:38:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:38:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:38:58 INFO - Return code: 0 02:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:38:58 INFO - https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:38:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:38:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:38:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:38:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:39:01 INFO - Downloaded 55397695 bytes. 02:39:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:39:01 INFO - mkdir: /builds/slave/test/properties 02:39:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:39:01 INFO - Writing to file /builds/slave/test/properties/build_url 02:39:01 INFO - Contents: 02:39:01 INFO - build_url:https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:39:02 INFO - Running post-action listener: _resource_record_post_action 02:39:02 INFO - Running post-action listener: set_extra_try_arguments 02:39:02 INFO - ##### 02:39:02 INFO - ##### Finished download-and-extract step (success) 02:39:02 INFO - ##### 02:39:02 INFO - ##### 02:39:02 INFO - ##### Running populate-webroot step. 02:39:02 INFO - ##### 02:39:02 INFO - Running pre-action listener: _resource_record_pre_action 02:39:02 INFO - Running main action method: populate_webroot 02:39:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:39:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:39:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:39:02 INFO - '--tppagecycles', 02:39:02 INFO - '7'], 02:39:02 INFO - 'tests': ['tsvgm']}}, 02:39:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:39:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:39:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:39:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:39:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:39:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:39:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:02 INFO - 'talos_options': ['--disable-e10s'], 02:39:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:39:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:02 INFO - 'talos_options': ['--disable-e10s'], 02:39:02 INFO - 'tests': ['damp', 'tps']}, 02:39:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:02 INFO - 'tests': ['damp', 'tps']}, 02:39:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:39:02 INFO - 'tests': ['dromaeo_dom']}, 02:39:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:39:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:39:02 INFO - 'tests': ['basic_compositor_video']}, 02:39:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:39:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:39:02 INFO - 'tests': ['a11yr', 02:39:02 INFO - 'ts_paint', 02:39:02 INFO - 'tpaint', 02:39:02 INFO - 'sessionrestore', 02:39:02 INFO - 'sessionrestore_no_auto_restore', 02:39:02 INFO - 'tabpaint']}, 02:39:02 INFO - 'other-e10s': {'tests': ['a11yr', 02:39:02 INFO - 'ts_paint', 02:39:02 INFO - 'tpaint', 02:39:02 INFO - 'sessionrestore', 02:39:02 INFO - 'sessionrestore_no_auto_restore', 02:39:02 INFO - 'tabpaint']}, 02:39:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:39:02 INFO - 'ts_paint', 02:39:02 INFO - 'tpaint', 02:39:02 INFO - 'sessionrestore', 02:39:02 INFO - 'sessionrestore_no_auto_restore', 02:39:02 INFO - 'tabpaint']}, 02:39:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:39:02 INFO - 'ts_paint', 02:39:02 INFO - 'tpaint', 02:39:02 INFO - 'sessionrestore', 02:39:02 INFO - 'sessionrestore_no_auto_restore', 02:39:02 INFO - 'tabpaint']}, 02:39:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:39:02 INFO - 'tests': ['a11yr', 02:39:02 INFO - 'ts_paint', 02:39:02 INFO - 'tpaint', 02:39:02 INFO - 'sessionrestore', 02:39:02 INFO - 'sessionrestore_no_auto_restore', 02:39:02 INFO - 'tabpaint']}, 02:39:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:39:02 INFO - 'tests': ['a11yr', 02:39:02 INFO - 'ts_paint', 02:39:02 INFO - 'tpaint', 02:39:02 INFO - 'sessionrestore', 02:39:02 INFO - 'sessionrestore_no_auto_restore', 02:39:02 INFO - 'tabpaint']}, 02:39:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:39:02 INFO - 'tests': ['tsvgx', 02:39:02 INFO - 'tsvgr_opacity', 02:39:02 INFO - 'tart', 02:39:02 INFO - 'tscrollx', 02:39:02 INFO - 'cart']}, 02:39:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:39:02 INFO - 'tsvgr_opacity', 02:39:02 INFO - 'tart', 02:39:02 INFO - 'tscrollx', 02:39:02 INFO - 'cart']}, 02:39:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:02 INFO - 'talos_options': ['--disable-e10s'], 02:39:02 INFO - 'tests': ['tp5o']}, 02:39:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:02 INFO - 'tests': ['tp5o']}, 02:39:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:02 INFO - 'talos_options': ['--disable-e10s', 02:39:02 INFO - '--xperf_path', 02:39:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:02 INFO - 'tests': ['tp5n']}, 02:39:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:39:02 INFO - 'talos_options': ['--xperf_path', 02:39:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:39:02 INFO - 'tests': ['tp5n']}}, 02:39:02 INFO - 'talos.zip': {'path': '', 02:39:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:39:02 INFO - Running post-action listener: _resource_record_post_action 02:39:02 INFO - ##### 02:39:02 INFO - ##### Finished populate-webroot step (success) 02:39:02 INFO - ##### 02:39:02 INFO - ##### 02:39:02 INFO - ##### Running create-virtualenv step. 02:39:02 INFO - ##### 02:39:02 INFO - Running pre-action listener: _resource_record_pre_action 02:39:02 INFO - Running main action method: create_virtualenv 02:39:02 INFO - Creating virtualenv /builds/slave/test/build/venv 02:39:02 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 02:39:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:39:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:39:02 INFO - Using real prefix '/usr' 02:39:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:39:02 INFO - Installing distribute.............................................................................................................................................................................................done. 02:39:05 INFO - Installing pip.................done. 02:39:05 INFO - Return code: 0 02:39:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:39:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:05 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 0x7f9260e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cae1c0>, '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 0x2caf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', '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 02:39:05 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 02:39:05 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 02:39:05 INFO - Using env: {'DISPLAY': ':0', 02:39:05 INFO - 'HOME': '/home/cltbld', 02:39:05 INFO - 'LANG': 'en_US.UTF-8', 02:39:05 INFO - 'LANGUAGE': 'en_US:en', 02:39:05 INFO - 'LOGNAME': 'cltbld', 02:39:05 INFO - 'MAIL': '/var/mail/cltbld', 02:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:05 INFO - 'MOZ_NO_REMOTE': '1', 02:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:05 INFO - 'NO_EM_RESTART': '1', 02:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:05 INFO - 'PWD': '/builds/slave/test', 02:39:05 INFO - 'SHELL': '/bin/bash', 02:39:05 INFO - 'SHLVL': '1', 02:39:05 INFO - 'TERM': 'linux', 02:39:05 INFO - 'TMOUT': '86400', 02:39:05 INFO - 'USER': 'cltbld', 02:39:05 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', 02:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:05 INFO - '_': '/tools/buildbot/bin/python'} 02:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:05 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 02:39:05 INFO - Cleaning up... 02:39:05 INFO - Return code: 0 02:39:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:39:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:05 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 0x7f9260e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cae1c0>, '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 0x2caf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', '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 02:39:05 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 02:39:05 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 02:39:05 INFO - Using env: {'DISPLAY': ':0', 02:39:05 INFO - 'HOME': '/home/cltbld', 02:39:05 INFO - 'LANG': 'en_US.UTF-8', 02:39:05 INFO - 'LANGUAGE': 'en_US:en', 02:39:05 INFO - 'LOGNAME': 'cltbld', 02:39:05 INFO - 'MAIL': '/var/mail/cltbld', 02:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:05 INFO - 'MOZ_NO_REMOTE': '1', 02:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:05 INFO - 'NO_EM_RESTART': '1', 02:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:05 INFO - 'PWD': '/builds/slave/test', 02:39:05 INFO - 'SHELL': '/bin/bash', 02:39:05 INFO - 'SHLVL': '1', 02:39:05 INFO - 'TERM': 'linux', 02:39:05 INFO - 'TMOUT': '86400', 02:39:05 INFO - 'USER': 'cltbld', 02:39:05 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', 02:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:05 INFO - '_': '/tools/buildbot/bin/python'} 02:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:05 INFO - Downloading/unpacking psutil>=3.1.1 02:39:05 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 02:39:05 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 02:39:05 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 02:39:05 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 02:39:05 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 02:39:05 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 02:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:39:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:07 INFO - Installing collected packages: psutil 02:39:07 INFO - Running setup.py install for psutil 02:39:07 INFO - building 'psutil._psutil_linux' extension 02:39:07 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 02:39:09 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 02:39:09 INFO - building 'psutil._psutil_posix' extension 02:39:09 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 02:39:09 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 02:39:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:39:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:39:09 INFO - Successfully installed psutil 02:39:09 INFO - Cleaning up... 02:39:09 INFO - Return code: 0 02:39:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:39:09 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:09 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:09 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 0x7f9260e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cae1c0>, '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 0x2caf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', '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 02:39:09 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 02:39:09 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 02:39:09 INFO - Using env: {'DISPLAY': ':0', 02:39:09 INFO - 'HOME': '/home/cltbld', 02:39:09 INFO - 'LANG': 'en_US.UTF-8', 02:39:09 INFO - 'LANGUAGE': 'en_US:en', 02:39:09 INFO - 'LOGNAME': 'cltbld', 02:39:09 INFO - 'MAIL': '/var/mail/cltbld', 02:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:09 INFO - 'MOZ_NO_REMOTE': '1', 02:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:09 INFO - 'NO_EM_RESTART': '1', 02:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:09 INFO - 'PWD': '/builds/slave/test', 02:39:09 INFO - 'SHELL': '/bin/bash', 02:39:09 INFO - 'SHLVL': '1', 02:39:09 INFO - 'TERM': 'linux', 02:39:09 INFO - 'TMOUT': '86400', 02:39:09 INFO - 'USER': 'cltbld', 02:39:09 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', 02:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:09 INFO - '_': '/tools/buildbot/bin/python'} 02:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:39:09 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 02:39:09 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 02:39:09 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 02:39:09 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 02:39:09 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 02:39:09 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 02:39:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:39:11 INFO - Installing collected packages: mozsystemmonitor 02:39:11 INFO - Running setup.py install for mozsystemmonitor 02:39:11 INFO - Successfully installed mozsystemmonitor 02:39:11 INFO - Cleaning up... 02:39:11 INFO - Return code: 0 02:39:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:39: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:11 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 0x7f9260e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cae1c0>, '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 0x2caf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', '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 02:39:11 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 02:39:11 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 02:39:11 INFO - Using env: {'DISPLAY': ':0', 02:39:11 INFO - 'HOME': '/home/cltbld', 02:39:11 INFO - 'LANG': 'en_US.UTF-8', 02:39:11 INFO - 'LANGUAGE': 'en_US:en', 02:39:11 INFO - 'LOGNAME': 'cltbld', 02:39:11 INFO - 'MAIL': '/var/mail/cltbld', 02:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:11 INFO - 'MOZ_NO_REMOTE': '1', 02:39:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:11 INFO - 'NO_EM_RESTART': '1', 02:39:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:11 INFO - 'PWD': '/builds/slave/test', 02:39:11 INFO - 'SHELL': '/bin/bash', 02:39:11 INFO - 'SHLVL': '1', 02:39:11 INFO - 'TERM': 'linux', 02:39:11 INFO - 'TMOUT': '86400', 02:39:11 INFO - 'USER': 'cltbld', 02:39:11 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', 02:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:11 INFO - '_': '/tools/buildbot/bin/python'} 02:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:11 INFO - Downloading/unpacking jsonschema==2.5.1 02:39:11 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 02:39:11 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 02:39:11 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 02:39:11 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 02:39:11 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 02:39:11 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 02:39:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:39:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:39:13 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 02:39:13 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 02:39:13 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 02:39:13 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 02:39:13 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 02:39:13 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 02:39:14 INFO - Downloading functools32-3.2.3-2.tar.gz 02:39:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:39:14 INFO - warning: no files found matching '*.txt' 02:39:14 INFO - no previously-included directories found matching 'build' 02:39:14 INFO - no previously-included directories found matching 'dist' 02:39:14 INFO - no previously-included directories found matching '.git*' 02:39:14 INFO - Installing collected packages: jsonschema, functools32 02:39:14 INFO - Running setup.py install for functools32 02:39:14 INFO - warning: no files found matching '*.txt' 02:39:14 INFO - no previously-included directories found matching 'build' 02:39:14 INFO - no previously-included directories found matching 'dist' 02:39:14 INFO - no previously-included directories found matching '.git*' 02:39:14 INFO - Successfully installed jsonschema functools32 02:39:14 INFO - Cleaning up... 02:39:14 INFO - Return code: 0 02:39:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9260e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cae1c0>, '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 0x2caf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', '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 02:39:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:39:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:39:14 INFO - Using env: {'DISPLAY': ':0', 02:39:14 INFO - 'HOME': '/home/cltbld', 02:39:14 INFO - 'LANG': 'en_US.UTF-8', 02:39:14 INFO - 'LANGUAGE': 'en_US:en', 02:39:14 INFO - 'LOGNAME': 'cltbld', 02:39:14 INFO - 'MAIL': '/var/mail/cltbld', 02:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:14 INFO - 'MOZ_NO_REMOTE': '1', 02:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:14 INFO - 'NO_EM_RESTART': '1', 02:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:14 INFO - 'PWD': '/builds/slave/test', 02:39:14 INFO - 'SHELL': '/bin/bash', 02:39:14 INFO - 'SHLVL': '1', 02:39:14 INFO - 'TERM': 'linux', 02:39:14 INFO - 'TMOUT': '86400', 02:39:14 INFO - 'USER': 'cltbld', 02:39:14 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', 02:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:14 INFO - '_': '/tools/buildbot/bin/python'} 02:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:14 INFO - Downloading/unpacking blobuploader==1.2.4 02:39:14 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 02:39:14 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 02:39:14 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 02:39:14 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 02:39:14 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 02:39:14 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 02:39:16 INFO - Downloading blobuploader-1.2.4.tar.gz 02:39:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:39:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:39:16 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 02:39:16 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 02:39:16 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 02:39:16 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 02:39:16 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 02:39:16 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 02:39:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:39:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:39:16 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 02:39:16 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 02:39:16 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 02:39:16 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 02:39:16 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 02:39:16 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 02:39:17 INFO - Downloading docopt-0.6.1.tar.gz 02:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:39:17 INFO - Installing collected packages: blobuploader, requests, docopt 02:39:17 INFO - Running setup.py install for blobuploader 02:39:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:39:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:39:17 INFO - Running setup.py install for requests 02:39:17 INFO - Running setup.py install for docopt 02:39:17 INFO - Successfully installed blobuploader requests docopt 02:39:17 INFO - Cleaning up... 02:39:17 INFO - Return code: 0 02:39:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39:17 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:17 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:17 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 0x7f9260e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cae1c0>, '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 0x2caf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', '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 02:39:17 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 02:39:17 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 02:39:17 INFO - Using env: {'DISPLAY': ':0', 02:39:17 INFO - 'HOME': '/home/cltbld', 02:39:17 INFO - 'LANG': 'en_US.UTF-8', 02:39:17 INFO - 'LANGUAGE': 'en_US:en', 02:39:17 INFO - 'LOGNAME': 'cltbld', 02:39:17 INFO - 'MAIL': '/var/mail/cltbld', 02:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:17 INFO - 'MOZ_NO_REMOTE': '1', 02:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:17 INFO - 'NO_EM_RESTART': '1', 02:39:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:17 INFO - 'PWD': '/builds/slave/test', 02:39:17 INFO - 'SHELL': '/bin/bash', 02:39:17 INFO - 'SHLVL': '1', 02:39:17 INFO - 'TERM': 'linux', 02:39:17 INFO - 'TMOUT': '86400', 02:39:17 INFO - 'USER': 'cltbld', 02:39:17 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', 02:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:17 INFO - '_': '/tools/buildbot/bin/python'} 02:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:18 INFO - Running setup.py (path:/tmp/pip-dtdM69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:18 INFO - Running setup.py (path:/tmp/pip-MCeVLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:18 INFO - Running setup.py (path:/tmp/pip-AwaJz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:39:18 INFO - Running setup.py (path:/tmp/pip-RsgTDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:39:18 INFO - Running setup.py (path:/tmp/pip-pY11O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:39:18 INFO - Running setup.py (path:/tmp/pip-a8rgxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:39:18 INFO - Running setup.py (path:/tmp/pip-LwfhuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:39:18 INFO - Running setup.py (path:/tmp/pip-ZBFYoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:39:18 INFO - Running setup.py (path:/tmp/pip-q2v0Or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:39:18 INFO - Running setup.py (path:/tmp/pip-q7xWbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:39:18 INFO - Running setup.py (path:/tmp/pip-nyXhCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:39:18 INFO - Running setup.py (path:/tmp/pip-ywJhWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:39:18 INFO - Running setup.py (path:/tmp/pip-spQuxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:39:18 INFO - Running setup.py (path:/tmp/pip-cPlSEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:19 INFO - Running setup.py (path:/tmp/pip-xk0PJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:39:19 INFO - Running setup.py (path:/tmp/pip-8zFR0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:39:19 INFO - Running setup.py (path:/tmp/pip-1BFUMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:39:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:39:19 INFO - Running setup.py install for manifestparser 02:39:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:39:19 INFO - Running setup.py install for mozcrash 02:39:19 INFO - Running setup.py install for mozdebug 02:39:19 INFO - Running setup.py install for mozdevice 02:39:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:39:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:39:19 INFO - Running setup.py install for mozfile 02:39:19 INFO - Running setup.py install for mozhttpd 02:39:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:39:19 INFO - Running setup.py install for mozinfo 02:39:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:39:19 INFO - Running setup.py install for mozInstall 02:39:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:39:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:39:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:39:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:39:20 INFO - Running setup.py install for mozleak 02:39:20 INFO - Running setup.py install for mozlog 02:39:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:39:20 INFO - Running setup.py install for moznetwork 02:39:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:39:20 INFO - Running setup.py install for mozprocess 02:39:20 INFO - Running setup.py install for mozprofile 02:39:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:39:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:39:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:39:20 INFO - Running setup.py install for mozrunner 02:39:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:39:20 INFO - Running setup.py install for mozscreenshot 02:39:20 INFO - Running setup.py install for moztest 02:39:20 INFO - Running setup.py install for mozversion 02:39:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:39:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:39:21 INFO - Cleaning up... 02:39:21 INFO - Return code: 0 02:39:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39:21 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:21 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:21 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 0x7f9260e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cae1c0>, '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 0x2caf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', '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 02:39:21 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 02:39:21 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 02:39:21 INFO - Using env: {'DISPLAY': ':0', 02:39:21 INFO - 'HOME': '/home/cltbld', 02:39:21 INFO - 'LANG': 'en_US.UTF-8', 02:39:21 INFO - 'LANGUAGE': 'en_US:en', 02:39:21 INFO - 'LOGNAME': 'cltbld', 02:39:21 INFO - 'MAIL': '/var/mail/cltbld', 02:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:21 INFO - 'MOZ_NO_REMOTE': '1', 02:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:21 INFO - 'NO_EM_RESTART': '1', 02:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:21 INFO - 'PWD': '/builds/slave/test', 02:39:21 INFO - 'SHELL': '/bin/bash', 02:39:21 INFO - 'SHLVL': '1', 02:39:21 INFO - 'TERM': 'linux', 02:39:21 INFO - 'TMOUT': '86400', 02:39:21 INFO - 'USER': 'cltbld', 02:39:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', 02:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:21 INFO - '_': '/tools/buildbot/bin/python'} 02:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:39:21 INFO - Running setup.py (path:/tmp/pip-ZOGCYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:39:21 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)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:39:21 INFO - Running setup.py (path:/tmp/pip-M8ntOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:39:21 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)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:39:21 INFO - Running setup.py (path:/tmp/pip-kPCsqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:39:21 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)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:39:21 INFO - Running setup.py (path:/tmp/pip-UX2Mtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:39:21 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)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:39:21 INFO - Running setup.py (path:/tmp/pip-EbSRy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:39:21 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)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:39:21 INFO - Running setup.py (path:/tmp/pip-ZTb6C_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:39:21 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)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:39:21 INFO - Running setup.py (path:/tmp/pip-6KW4JS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:39:21 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)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:39:21 INFO - Running setup.py (path:/tmp/pip-_wV4Vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:39:21 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)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:39:21 INFO - Running setup.py (path:/tmp/pip-aXRnys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:39:21 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)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:39:21 INFO - Running setup.py (path:/tmp/pip-TMwtE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 02:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:39:21 INFO - Running setup.py (path:/tmp/pip-Mo82A5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:39:22 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)) 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:39:22 INFO - Running setup.py (path:/tmp/pip-1zVOnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:39:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:39:22 INFO - Running setup.py (path:/tmp/pip-BRYeN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:39:22 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)) 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:39:22 INFO - Running setup.py (path:/tmp/pip-PlytUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:39:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:22 INFO - Running setup.py (path:/tmp/pip-7Sr0cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:39:22 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)) 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:39:22 INFO - Running setup.py (path:/tmp/pip-gxlCvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:39:22 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)) 02:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:39:22 INFO - Running setup.py (path:/tmp/pip-TAdzfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:39:22 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)) 02:39:22 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)) 02:39:22 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)) 02:39:22 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)) 02:39:22 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)) 02:39:22 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)) 02:39:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:24 INFO - Downloading blessings-1.6.tar.gz 02:39:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:39:24 INFO - Installing collected packages: blessings 02:39:24 INFO - Running setup.py install for blessings 02:39:24 INFO - Successfully installed blessings 02:39:24 INFO - Cleaning up... 02:39:24 INFO - Return code: 0 02:39:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:39:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:24 INFO - Reading from file tmpfile_stdout 02:39:24 INFO - Current package versions: 02:39:24 INFO - argparse == 1.2.1 02:39:24 INFO - blessings == 1.6 02:39:24 INFO - blobuploader == 1.2.4 02:39:24 INFO - docopt == 0.6.1 02:39:24 INFO - functools32 == 3.2.3-2 02:39:24 INFO - jsonschema == 2.5.1 02:39:24 INFO - manifestparser == 1.1 02:39:24 INFO - mozInstall == 1.12 02:39:24 INFO - mozcrash == 0.17 02:39:24 INFO - mozdebug == 0.1 02:39:24 INFO - mozdevice == 0.48 02:39:24 INFO - mozfile == 1.2 02:39:24 INFO - mozhttpd == 0.7 02:39:24 INFO - mozinfo == 0.9 02:39:24 INFO - mozleak == 0.1 02:39:24 INFO - mozlog == 3.2 02:39:24 INFO - moznetwork == 0.27 02:39:24 INFO - mozprocess == 0.22 02:39:24 INFO - mozprofile == 0.28 02:39:24 INFO - mozrunner == 6.11 02:39:24 INFO - mozscreenshot == 0.1 02:39:24 INFO - mozsystemmonitor == 0.3 02:39:24 INFO - moztest == 0.7 02:39:24 INFO - mozversion == 1.4 02:39:24 INFO - psutil == 3.1.1 02:39:24 INFO - requests == 1.2.3 02:39:24 INFO - wsgiref == 0.1.2 02:39:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:39:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:24 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 0x7f9260e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cae1c0>, '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 0x2caf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', '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 02:39:24 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 02:39:24 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 02:39:24 INFO - Using env: {'DISPLAY': ':0', 02:39:24 INFO - 'HOME': '/home/cltbld', 02:39:24 INFO - 'LANG': 'en_US.UTF-8', 02:39:24 INFO - 'LANGUAGE': 'en_US:en', 02:39:24 INFO - 'LOGNAME': 'cltbld', 02:39:24 INFO - 'MAIL': '/var/mail/cltbld', 02:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:24 INFO - 'MOZ_NO_REMOTE': '1', 02:39:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:24 INFO - 'NO_EM_RESTART': '1', 02:39:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:24 INFO - 'PWD': '/builds/slave/test', 02:39:24 INFO - 'SHELL': '/bin/bash', 02:39:24 INFO - 'SHLVL': '1', 02:39:24 INFO - 'TERM': 'linux', 02:39:24 INFO - 'TMOUT': '86400', 02:39:24 INFO - 'USER': 'cltbld', 02:39:24 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', 02:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:24 INFO - '_': '/tools/buildbot/bin/python'} 02:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:25 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)) 02:39:25 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)) 02:39:25 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)) 02:39:25 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)) 02:39:25 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)) 02:39:25 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)) 02:39:25 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)) 02:39:25 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)) 02:39:25 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)) 02:39:25 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)) 02:39:25 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)) 02:39:25 INFO - Cleaning up... 02:39:25 INFO - Return code: 0 02:39:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:39:25 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:25 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:25 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 0x7f9260e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cae1c0>, '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 0x2caf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', '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 02:39:25 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 02:39:25 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 02:39:25 INFO - Using env: {'DISPLAY': ':0', 02:39:25 INFO - 'HOME': '/home/cltbld', 02:39:25 INFO - 'LANG': 'en_US.UTF-8', 02:39:25 INFO - 'LANGUAGE': 'en_US:en', 02:39:25 INFO - 'LOGNAME': 'cltbld', 02:39:25 INFO - 'MAIL': '/var/mail/cltbld', 02:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:25 INFO - 'MOZ_NO_REMOTE': '1', 02:39:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:25 INFO - 'NO_EM_RESTART': '1', 02:39:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:25 INFO - 'PWD': '/builds/slave/test', 02:39:25 INFO - 'SHELL': '/bin/bash', 02:39:25 INFO - 'SHLVL': '1', 02:39:25 INFO - 'TERM': 'linux', 02:39:25 INFO - 'TMOUT': '86400', 02:39:25 INFO - 'USER': 'cltbld', 02:39:25 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', 02:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:25 INFO - '_': '/tools/buildbot/bin/python'} 02:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:39:25 INFO - Cleaning up... 02:39:25 INFO - Return code: 0 02:39:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:39:25 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:25 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:39:25 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9260e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cae1c0>, '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 0x2caf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', '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 02:39:25 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', 'flake8'] in /builds/slave/test/build 02:39:25 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 flake8 02:39:25 INFO - Using env: {'DISPLAY': ':0', 02:39:25 INFO - 'HOME': '/home/cltbld', 02:39:25 INFO - 'LANG': 'en_US.UTF-8', 02:39:25 INFO - 'LANGUAGE': 'en_US:en', 02:39:25 INFO - 'LOGNAME': 'cltbld', 02:39:25 INFO - 'MAIL': '/var/mail/cltbld', 02:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:25 INFO - 'MOZ_NO_REMOTE': '1', 02:39:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:25 INFO - 'NO_EM_RESTART': '1', 02:39:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:25 INFO - 'PWD': '/builds/slave/test', 02:39:25 INFO - 'SHELL': '/bin/bash', 02:39:25 INFO - 'SHLVL': '1', 02:39:25 INFO - 'TERM': 'linux', 02:39:25 INFO - 'TMOUT': '86400', 02:39:25 INFO - 'USER': 'cltbld', 02:39:25 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', 02:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:25 INFO - '_': '/tools/buildbot/bin/python'} 02:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:39:25 INFO - Downloading/unpacking flake8 02:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:39:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:39:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:39:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:39:27 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 02:39:27 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 02:39:27 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 02:39:27 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 02:39:27 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 02:39:27 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 02:39:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:39:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:39:27 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 02:39:27 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 02:39:27 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 02:39:27 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 02:39:27 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 02:39:27 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 02:39:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:39:27 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 02:39:27 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 02:39:27 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 02:39:27 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 02:39:27 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 02:39:27 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 02:39:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:39:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:39:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:39:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:39:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:39:28 INFO - no previously-included directories found matching 'docs/_build' 02:39:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:39:28 INFO - Running setup.py install for pep8 02:39:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:39:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:39:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:39:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:39:28 INFO - no previously-included directories found matching 'docs/_build' 02:39:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:39:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:39:28 INFO - Cleaning up... 02:39:28 INFO - Return code: 0 02:39:28 INFO - Running post-action listener: _resource_record_post_action 02:39:28 INFO - Running post-action listener: _start_resource_monitoring 02:39:28 INFO - Starting resource monitoring. 02:39:28 INFO - ##### 02:39:28 INFO - ##### Finished create-virtualenv step (success) 02:39:28 INFO - ##### 02:39:28 INFO - ##### 02:39:28 INFO - ##### Running install step. 02:39:28 INFO - ##### 02:39:28 INFO - Running pre-action listener: _resource_record_pre_action 02:39:28 INFO - Running main action method: install 02:39:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:39:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:39:28 INFO - Reading from file tmpfile_stdout 02:39:28 INFO - Detecting whether we're running mozinstall >=1.0... 02:39:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:39:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:39:28 INFO - Reading from file tmpfile_stdout 02:39:28 INFO - Output received: 02:39:28 INFO - Usage: mozinstall [options] installer 02:39:28 INFO - Options: 02:39:28 INFO - -h, --help show this help message and exit 02:39:28 INFO - -d DEST, --destination=DEST 02:39:28 INFO - Directory to install application into. [default: 02:39:28 INFO - "/builds/slave/test"] 02:39:28 INFO - --app=APP Application being installed. [default: firefox] 02:39:28 INFO - mkdir: /builds/slave/test/build/application 02:39:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:39:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:39:44 INFO - Reading from file tmpfile_stdout 02:39:44 INFO - Output received: 02:39:44 INFO - /builds/slave/test/build/application/firefox/firefox 02:39:44 INFO - Running post-action listener: _resource_record_post_action 02:39:44 INFO - ##### 02:39:44 INFO - ##### Finished install step (success) 02:39:44 INFO - ##### 02:39:44 INFO - ##### 02:39:44 INFO - ##### Running run-tests step. 02:39:44 INFO - ##### 02:39:44 INFO - Running pre-action listener: _resource_record_pre_action 02:39:44 INFO - Running main action method: run_tests 02:39:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:39:44 INFO - Python 2.7.3 02:39:44 INFO - Return code: 0 02:39:44 INFO - grabbing minidump binary from tooltool 02:39:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:39:44 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 0x2cae1c0>, '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 0x2caf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:39:44 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 02:39:44 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 02:39:44 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 02:39:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:39:45 INFO - Return code: 0 02:39:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:39:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:39:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:39:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:39:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:39:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:39:46 INFO - Return code: 0 02:39:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 02:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 02:39:46 INFO - Using env: {'DISPLAY': ':0', 02:39:46 INFO - 'HOME': '/home/cltbld', 02:39:46 INFO - 'LANG': 'en_US.UTF-8', 02:39:46 INFO - 'LANGUAGE': 'en_US:en', 02:39:46 INFO - 'LOGNAME': 'cltbld', 02:39:46 INFO - 'MAIL': '/var/mail/cltbld', 02:39:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:39:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:39:46 INFO - 'MOZ_NO_REMOTE': '1', 02:39:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:39:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:39:46 INFO - 'NO_EM_RESTART': '1', 02:39:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:39:46 INFO - 'PWD': '/builds/slave/test', 02:39:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:39:46 INFO - 'SHELL': '/bin/bash', 02:39:46 INFO - 'SHLVL': '1', 02:39:46 INFO - 'TERM': 'linux', 02:39:46 INFO - 'TMOUT': '86400', 02:39:46 INFO - 'USER': 'cltbld', 02:39:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779', 02:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:39:46 INFO - '_': '/tools/buildbot/bin/python'} 02:39:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 02:39:46 INFO - mozversion application_buildid: 20160613013726 02:39:46 INFO - mozversion application_changeset: 405bdbc110e121282d453fcf66cbf0daa8c3441e 02:39:46 INFO - mozversion application_display_name: Nightly 02:39:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:39:46 INFO - mozversion application_name: Firefox 02:39:46 INFO - mozversion application_remotingname: firefox 02:39:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:39:46 INFO - mozversion application_vendor: Mozilla 02:39:46 INFO - mozversion application_version: 50.0a1 02:39:46 INFO - mozversion platform_buildid: 20160613013726 02:39:46 INFO - mozversion platform_changeset: 405bdbc110e121282d453fcf66cbf0daa8c3441e 02:39:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:39:46 INFO - mozversion platform_version: 50.0a1 02:39:46 INFO - using testdate: 1465810786 02:39:46 INFO - actual date: 1465810786 02:39:46 INFO - starting webserver on 'localhost:59477' 02:39:46 INFO - SUITE-START | Running 2 tests 02:39:46 INFO - TEST-START | dromaeo_css 02:39:46 INFO - operating with platform_type : linux_ 02:39:46 INFO - Initialising browser for dromaeo_css test... 02:39:46 INFO - TEST-INFO | started process 3350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDxHGZ_/profile http://localhost:59477/getInfo.html) 02:39:52 INFO - PROCESS | 3350 | __metrics Screen width/height:1600/1200 02:39:52 INFO - PROCESS | 3350 | colorDepth:24 02:39:52 INFO - PROCESS | 3350 | Browser inner width/height: 1024/697 02:39:52 INFO - PROCESS | 3350 | __metrics 02:39:53 ERROR - PROCESS | 3350 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:39:54 INFO - TEST-INFO | 3350: exit 0 02:39:54 INFO - Browser initialized. 02:39:54 INFO - Running cycle 1/1 for dromaeo_css test... 02:39:54 INFO - TEST-INFO | started process 3471 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDxHGZ_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:40:06 INFO - PROCESS | 3471 | RSS: Main: 186118144 02:40:06 INFO - PROCESS | 3471 | 02:40:55 INFO - PROCESS | 3471 | 1465810855829 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] 02:43:08 INFO - PROCESS | 3471 | Cycle 1(1): loaded http://localhost:59477/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59477/tests/dromaeo/cssquery-ext.html) 02:43:09 INFO - PROCESS | 3471 | RSS: Main: 189161472 02:43:09 INFO - PROCESS | 3471 | 02:46:11 INFO - PROCESS | 3471 | Cycle 1(1): loaded http://localhost:59477/tests/dromaeo/cssquery-ext.html (next: http://localhost:59477/tests/dromaeo/cssquery-jquery.html) 02:46:12 INFO - PROCESS | 3471 | RSS: Main: 187838464 02:46:12 INFO - PROCESS | 3471 | 02:49:14 INFO - PROCESS | 3471 | Cycle 1(1): loaded http://localhost:59477/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59477/tests/dromaeo/cssquery-mootools.html) 02:49:14 INFO - PROCESS | 3471 | RSS: Main: 189063168 02:49:14 INFO - PROCESS | 3471 | 02:52:16 INFO - PROCESS | 3471 | Cycle 1(1): loaded http://localhost:59477/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59477/tests/dromaeo/cssquery-prototype.html) 02:52:17 INFO - PROCESS | 3471 | RSS: Main: 186871808 02:52:17 INFO - PROCESS | 3471 | 02:55:19 INFO - PROCESS | 3471 | Cycle 1(1): loaded http://localhost:59477/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59477/tests/dromaeo/cssquery-yui.html) 02:55:20 INFO - PROCESS | 3471 | RSS: Main: 188723200 02:55:20 INFO - PROCESS | 3471 | 02:58:22 INFO - PROCESS | 3471 | Cycle 1(1): loaded http://localhost:59477/tests/dromaeo/cssquery-yui.html (next: http://localhost:59477/tests/dromaeo/cssquery-dojo.html) 02:58:23 INFO - PROCESS | 3471 | RSS: Main: 189890560 02:58:23 INFO - PROCESS | 3471 | 02:58:23 INFO - PROCESS | 3471 | __start_tp_report 02:58:23 INFO - PROCESS | 3471 | _x_x_mozilla_page_load 02:58:23 INFO - PROCESS | 3471 | _x_x_mozilla_page_load_details 02:58:23 INFO - PROCESS | 3471 | |i|pagename|runs| 02:58:23 INFO - PROCESS | 3471 | |0;dojo.html;2632.3419145213697;2702.2974026753045;2718.592211168326;2719.1434698070107;2725.1415804021744;4851.80592776289;4894.951050489494;4918.606511479077;4988.176950803113;5036.043151801156;4765.261384485401;4887;4909.263610458433;4916.410030796309;4978.004399120181;4477.798499067541;4521;4632.281996290563;4634.281686338623;4647.55848194421;586.0541152675911;4471.262241730111;4494.550544945512;4572.131295053946;4627.375304333906;4524.208263553898;4535.841245556389;4540.228161212602;4561.475430325522;4587.885302867422;4417.160739459492;4565.589096981287;4584.518625544337;4586.862394128181;4607.0325231701045;4477.059817438342;4491.25894227452;4495.23580991229;4498.977505112486;4532;4922.950770492321;4932.383452068491;4966.15575352191;4966.652334336598;4983.72589507577;5185.766640501187;5250.081235783722;5284.286621306152;5313.335833020872;5374.596905232123;5313.628046036779;5313.654612450178;5320.6275560710765;5323.254744335796;5366.597505187126;4946.826861059882;4951.183054795991;4951.9752401237765;4959.528844759778;4962.354893863775;5200.323957885526;5271.710055946883;5301.496357845998;5334.199870019528;5380.408155102936;5082.1360368737405;5102.107131252016;5109.642325037212;5111.591072714174;5124.846254612367;5198.792048318025;5205.7917683293;5219.686818790885;5225.190095535198;5258.789648414097;5068.189089745623;5116.2069879168785;5158.432572417031;5184.870378240499;5187.351581052369;5037.899242015213;5044.571211447068;5055.115354812893;5069.721165335942;5105.081085404663;4324.0919406924895;4340.327249276367;4345.391645169679;4350.434443522385;4391.692581519263;3789.204267103884;3868.8839334819436;3901.882943511699;3926.155876486569;3941.5270167580074;4494.910101798011;4521.389612402284;4522.389477420506;4558.407407037131;4560.1335746208115;5109.821156259513;5313.123334649739;5331.413544510101;5337.172738225581;5358.91961620576;4403.119376124788;4469.9776501117285;4473.731576105444;4482.39487669167;4483.394741709827;4718.528147185322;4726.550977657117;4731.243001119804;4746.69146505483;4760.619150468024;4785.330053792542;4914.729689867092;4918.901621967612;4924.704517728947;4959.082569724613;5297.364316282071;5333.359996800409;5350.277712508917;5359.919601205907;5414.242006119068;4936.358273424432;4938.2839488273285;4948.480409556944;4952.653314268111;4978.5270399312;4998.650094493496;5125.410577783603;5142.100132476727;5185.844424667266;5246.871922536673;5246.842594722164;5263.473652634706;5265.631405801557;5299.205119232146;5303.9204411934625;5115.283860259641;5119.385673719177;5124.948750512447;5151.381834179922;5164.147915593885;4928;4971.726555039363;4974.801007959641;4990.975045124751;5130.384353877409;4948.529889660476;4999.675021123615;5025.522575355335;5046.77289521965;5081.695098294114;5131.461196574306;5139.383274006994;5152;5158.277841102324;5228.503292187236;4742.715437073786;4833.830815921426;4986.526280003394;5041.6722913010535;5047.924281135859 02:58:23 INFO - PROCESS | 3471 | |1;ext.html;535.3343977953532;575.4360726488042;591.0779184472221;595.1370512756503;605.7849463440476;34948.65051349486;40914.59085409145;40973.7951310243;41016.17967640646;41113.58886411135;40355;41060.17879642405;41477.37783933243;41485.79257103718;41505.792471037676;7801.92198078019;7875.251851074138;7901.644426000815;7951.284384405402;7967.521948683097;7739.303462688357;7797.532148071134;7825.0218722659665;7837.764867053969;7840.255175758322;7832.295093441589;7869.803254918645;7884.448088633798;7888.408369372291;7895.8420831583335;7817.335526480256;7829.843403131934;7842.764717058469;7847;7849.411294152905;7803.102643196048;7821.765347039598;7845.882311765328;7857.607119643995;7858.921410785876;38114;38263.617363826284;38302.61697383018;38548.807255963824;38586;3203.9038828835173;3206.198450387403;3220.9355812883846;3252.788568743024;3512.525809015776;29923.70076299253;29942.25144371408;30178.84910575455;30194.698053019627;30942.53586196209;3207.631122420928;3248.3990461764647;3265.297960938386;3265.510173473974;3274.590676165479;244089;247240;247467;249436.9999999982;250069;31873;32874.342513150084;48405;48451.75774121107;48490;33807.323853522794;33988.66011339904;34104.14739631529;34224.31551368959;34437.827810860785;12633.431495582721;12716.554920577735;12790.936045319713;12804.61586152417;12825;10591.94704026475;10653.84019239712;10706.89293107059;10730.517126729315;10750.462476876124;7814.804629884298;7846.372290216769;7901.525908445512;7919.881201781978;7939.2060793920145;3121.438141134572;3121.5161649944293;3133.905982820519;3169.9683003170135;3179.856906439216;852.4885068958575;898.6589933223988;902.5081330674798;973.5035132082547;978.6574698855486;27999.860000699868;28080.578791318145;28495.857520712263;28547.286317841805;28926.855365723037;921.2077613252598;1004.9045340692622;1021.0657248617432;1034.7413146713322;1052.9894701052892;14072.577822665336;14150.716985660229;14373.928130359282;14492.565223043326;14505.782413263809;385955;624324;639508;639527;639721;51080;51218;51750.48249517532;51787.74106129445;52086.21870671943;1188.3701638131804;1215.1008253892055;1220.8840160184768;1224.4918358881143;1225.926444413338;28302.716972830007;29253.41493170167;29491.85254073802;29891.850540748026;30063;44118.11763764771;44794.77602611966;44967;44979;45116.77441612771;359675;363868;364377;364785;365871;25762.227133186036;25883.352916176493;26392.604110937966;26397.604035939094;26429.471410572067;43394.566054339055;43930.780346099345;44050.77974610106;44313;44722.77638611786;37603.81198093992;38135.2372952545;38181;38195.618043820316;38449;36680.26639467249;38061.42907856329;38090.42864357092;38097.04757380977;38255.617443825206;32827.67172328342;36345.636543634224;37660.811695941346;37866.24267514579;37910.43134353042;32151.517727233644;33301.16747081342;33853.66146338505;33932;34122;25047.248582542554;25395.87302063478;25664.358391040372;25854.482910342063;26302.736972630028 02:58:23 INFO - PROCESS | 3471 | |2;jquery.html;377.5107202087765;377.66576579726944;382.2336215887146;396.6588733689025;399.16574359588475;15529.378824847006;16292.429764958244;16520.339186432528;16766.329346826144;16906.40827571034;15497.845021549781;16308;16360.509184724448;16386.180690965433;17032.48902532923;4630.536946305368;4788.664793464459;4800.495947925452;4805.951940480603;4841.443234028079;3532.982335088321;5217.765200565965;5501.889962200754;5504.669719816804;5577.107662773957;5522.641028333165;5558.610897237195;5574;5586.441355864401;5635.971820140914;6051.727672254715;6057.3336932937345;6068.544859135561;6072.817815465543;6075.301340345873;4651.674382793206;4932.8273510427325;5457.2359869618285;5466.043442397565;5474.315710536183;19673.508162295915;20052.298169563994;20501.794982050287;20610.587788244302;20643.587128257503;1888.2447021191497;1908;1970.458124015907;1995.7305763722002;2004.4587961250381;8973;9145.451272923647;9258.583363748647;9487.098725621125;12016.759664806656;1604.4945842059715;1674.2047527424497;1687.7468379743013;1690.6956747785393;1719.0983403517464;68619;70279.64860175666;70680;71011.28988710098;71085.2891471089;9347.252219822398;9371.906280937239;9398.718038458857;9415.293852960918;9918.817860070772;12392;12524.373781310898;12538.059645526622;12572.182808117443;12763.170393924365;7014.824629384306;7026.578405295699;7100.502964792415;7162.964185179041;7274.599897005715;6779.796606101825;6785.55893866907;6922.826929326807;6923.065386172903;6929.688164032631;4178;4188.6230239278;4285.421468101828;4357.934630980538;4425.668074894395;1686.3928985565433;1754.7894252689503;1834.7711013601606;1848.778146622414;1893.4035778729656;843.3000609494105;862.4394143806451;919.9402038867452;935.1350001248818;938.0853667674099;15276.541703748682;16686.33254669824;18273.3604323848;18525.351612693492;18913.7162942556;806.3871457692196;839.2740279658174;846.6994217052858;862.5859587398085;911.2345629671108;9331.486768227813;9739.220862330996;9790.902090979142;9844.310898237054;9969.950150249202;405398;407097;408329;409956;411187;80344;81500.18499814926;82626.58686706529;84418;84710;908.5593487158723;959.9280053995979;964.238251781099;968.7674958010168;976.8925418203992;14774.33515491827;14843;14903.254837258311;14983.40066397332;15137.394504219708;37462;37627.2474550502;37710.81144594259;37745.98032157366;37785;48786;54821;55710.72144639251;56040.15939760825;56530.15204772014;6717.697703603448;7133.928660713326;7202.207757146605;7365.2634736525915;7616.8476630468185;8842.955785221033;11312.20814543007;11450;11891.643250702493;11962.700932476757;10097.747556310856;10269;10443.634472793416;10469.633562825264;10521.421321827373;10442.68671939843;10467.424291664032;10780.622678206226;10940.835887461535;10991.120710342993;10349.172066234834;10497.52761125736;10574.471276436301;10586.311889727143;10697.786044279226;6652.301508341748;8016.238457346542;8152.510849349058;8159.102498725017;8163.102058773649;8412.747617571482;9817.31278810505;10029.147522460673;10171.949140254252;10402.791944160923 02:58:23 INFO - PROCESS | 3471 | |3;mootools.html;1392.519580744643;1413.1168019987508;1466.6919946811176;1645.3583102589992;1653.669266146771;6936.9306306936915;7623.54258744475;7631;8174.059983101945;8200.220979006992;7726;7977.20227977202;8039.2362725541125;8072.677092916291;8077.8788318175275;2192.9780702192975;2219.9889000554977;2222.75549689534;2231.3306008197555;2234.955300893981;2160.157538559963;2177.096504950444;2202.284257616273;2217.833662475313;2219.1345375303645;2193.3310340346266;2198.3404978506383;2212.1593794358123;2213.1700612270397;2249.460129568908;2138.4653836540942;2140.9357719268446;2141.8929053547417;2144.9463763405884;2150.7204063471804;2148.52732398872;2183.0503730877117;2187.9781202187933;2191.5178660694623;2195.9451013724624;8067.112617612058;8075.798105047362;8099.311558517533;8147.226013528764;8177.509349438993;4602.447706275235;4758.666893317469;4765.69023013503;4783.1868582341085;4794.376731024944;2871.9086747036204;2917.124862541229;2970.2425881400322;2980.135760629415;2999.7150270724246;843.1273631791128;862.5773371048203;892.5403417240127;899.419874181156;900.9144131307515;11254.43727813606;11286.830697539626;11301.717457063556;11326.15053870963;11338.829917551244;4224.725392849455;4245.3844192591905;4304.397384366192;4310.31035034393;4416.447944006999;9379.812403751886;9391.29565282593;9483.857742133874;9504.192143667728;9509;4730.763461826964;4738.691985020962;4760.214564596803;4766.95233047672;4771.95228047715;3682.2819550187455;4180.644645205191;4280.5505421930875;4322.7190232634775;4331.761753103609;3725.385311423585;3733.5146430964346;3794.392897136445;3821.3312670283144;3845.65389114981;1186.4516805568815;1203.602811072344;1210.4250481021445;1215.2708374974945;1223.6757259326287;708.4721882197796;828.0394742099136;848.5757121439281;858.686579398515;869.3914260018013;5039.420466646309;5282.894342113136;5382.434844341366;5496.1755736639825;5543.584231182677;872.2062922740275;884.9203971155181;906.0971958886417;907.9092090791;911.7811725185908;3727.552693676776;3740.401535754266;3770.245950809794;3775.2260786538695;3834.731568790158;9666.95166524163;9840;9938.403695778277;10065.446400448045;10098.697039088838;9913.603455861828;9938.850917236103;9996.700098997042;10020.64927727526;10055.949720251352;7204.711811527585;7487.9891214687495;7494.700211991569;7532.887006694904;7550.6602202901;5188.610854186027;5268.209768534751;5317.867053323698;5394.163904594794;5441.863953401196;9088.363814532919;9131.863022054808;9148.817023659623;9176.541172941194;9187.265018798615;9020.233280171258;9173.44959302444;9283.48940808235;9307.20888724439;9371.344005919793;5768.567357448292;6109.266887973472;6356.586821856565;6361;6417.39034791694;7622.199669034671;7660.387169026576;7684.193159718149;7747.573883436465;7770.689172433039;6803;7072.257412971564;7084.07906972111;7121.287871212838;7209.531380460253;6674.966625166843;6718.6976586054725;6905.1713794345;6939.410150137295;7158.964205179149;6333.113364128933;6360.204974378203;6363.5545511813725;6393.360663933756;6422.6467544285515;4669.579737823612;4684.812607495662;4698;4755.83354582588;4766.833160839354;4757.072370887644;4783.4738178801;4807.278908163804;4828.348172996601;4852.223644216909 02:58:23 INFO - PROCESS | 3471 | |4;prototype.html;293.0841121495327;298.48511317976494;299.54469206805663;300.8540857684024;302.37861195243767;5021.548060674539;5058.165402708549;5103.693778373291;5119.974400127999;5140.074786538422;5015.949840501594;5038.345015148035;5054.609982254872;5054.721990290533;5075.74621268936;3745.614122774577;3829.1767270036935;3897.610238976108;3965.3655415133585;3973.384125460558;3894.2600905827944;3931.174453364797;3942.1327307992196;3949.605039496056;3964.405339199114;3949.9012524686827;3957.881263562098;3967.0875698589343;3972.245273398045;3976.6619837313865;3900.8829735107706;3939.8030098495246;3968.047668559525;3968.226195891788;3996.8001599920035;3450.6721861423125;3502.667246611568;3506.3870619515055;3523;3525.894223173283;4878;4889.046635906;4894.559489645949;4922.384701912261;4923.507649235084;4407.779611019469;4553.612942899857;4573.862784116482;4597.287420449836;4606.5393460654;5270.288511050997;5273.551748101416;5290.603204759658;5309.062192299822;5315.681059136464;3844.615538446161;3850;3854.1713531590844;3856.903577410559;3858.5723282385416;5398.272552783111;5499.862503437406;5577.3028371453565;5582.944170558283;5619.241402410663;3973.4238535412205;3984.2629113614075;3998.9400158997637;4010.5588385277597;4026.979865100656;4072.470578824734;4072.9838729828925;4074.7555146691293;4075.633193012643;4083.85706500277;4553.134904368159;4562.406887104655;4578.153041687298;4589.059242855206;4591.9081618367445;5067.746612669425;5330;5332.626716129911;5354.491323324278;5354.8661283467445;1386.3692020130816;1402.9649258768613;1408.507022542102;1409.4080486195821;1416.362636813438;866.9956650216709;883.2845395229884;884.3544212724747;919.8804155459748;924.7734305095161;4453.665975051884;4572.862814115582;4584.991301913574;4658.836940707059;4665.836695715634;5394.487523685244;5454.209139674725;5468.433857728762;5561.886483136383;5574.777008919679;4418.961544037149;4568.880624247081;4585.495595484494;4593.28804035375;4596.241620132708;2889.2632378743288;2915.7230063144393;2918.7227213415117;2924.8830046798316;2946.36653119576;5085.949140508622;5107.208382700687;5110.948890511122;5132.769025393866;5147.716875571879;5428.864278393072;5478.863028424242;5572.5263352614675;5581.972090139605;5586.229295225707;5063.215201643678;5119.385673719177;5125.410577783603;5142.1772516397195;5143.8456846294675;5501.917471237854;5520.834374968757;5523.447655234444;5531.142672885549;5553.250311207935;5171.974140129275;5372.328458942632;5390.838274851761;5407.324084489439;5410.864728381822;5080.298100136348;5087.720175390389;5125.411122552021;5138.794448222179;5139.229115632685;3982.6415622594104;4022.1553473770837;4051.149258655715;4051.5340735815757;4059.3099173141227;5325.680459172462;5531.695756733418;5545.639533430314;5550.27846379968;5585.162225666182;5284.656497327662;5307.416184219655;5315.352240805362;5353.839384818461;5412.377576578744;5257.740201075358;5262.289590905332;5284.471552844685;5298.390685071112;5343.477109023909;4989.027139707722;5345.759440825094;5363.463653634762;5364.5171934524515;5386.192071189353;5225.92161117576;5274.839535302227;5397.382269599319;5429.864253393696;5468.960897429476;5233.450487698889;5243.973780131075;5270.920936185884;5319.335083114611;5330.466953304794 02:58:23 INFO - PROCESS | 3471 | |5;yui.html;644.3266786208412;695.4332219241321;713.333033613571;738.2138023005499;780.3094261578505;12569.434375453104;12674.809877851829;12679.112462127632;12719.809202861952;12904.161229520074;12519.123661343687;13182.340882955838;13205.669858253548;13453.596392108228;13454.5290914818;624.4660815003175;794.5987276425398;800.2877439079224;802.1296892871242;802.5906787538369;772.308783638643;793.5238856686;793.9206079392044;797.6490344248512;800.139849661616;835.6156168162653;835.8955130608674;839.5172775653992;841.6423020216414;841.8863453433769;829.6805729794013;830.1325115254574;830.464350493928;831.501099340397;834.7579202031465;603.9547033972469;605.1799811255773;606.066657347684;607.3713706313988;609.8048624440181;12579.622611321674;12691.175073620278;12706.809397859039;12752.10735248533;12759.298238596873;12457.252564846047;12555.811662825065;12743.681407964783;12841.357932103358;13264.137831040951;10474.21443391741;10541.631042913461;10601.946990265;10760.154458670308;10772.814990351055;3224.210068533201;3316.1543806329473;3361.1429085583018;3367.3770352484867;3368.360011597789;61312;62201;63145;63759.36240637627;63825.04262436067;9734.221262299;9917.30578859473;9919.305648604528;9953.353032052893;10040.69877903664;17888.195031223626;17939.820601793814;17948.192331345123;17958.730619040725;18072.457826265232;6782.118324617768;6954.513184077167;7022.438204943593;7055.858882822417;7069.434445244368;3695.7412981091065;3837.0407398150464;3893.766374017568;3920.3531417316394;3995.380715989026;3029.6515900671707;3106.8446577671025;3120.453920563892;3123.4377811993604;3136.090533745234;497.6640767481935;504.9596032317406;508.8524327944855;515.0008982573795;523.8349919775259;543.5570010441556;572.5419664268569;574.8821491594213;585.809611876142;594.3551246897078;6898.379145876896;7029.718811247595;7230.493865429369;7232.891506627405;7406.444516661164;567.2398985359638;567.3617180671745;570.2216474512261;574.0442163797231;585.5110982329717;3600.7299452541165;3674.632536746304;3699.7595156314756;3701.296753616858;3753.399456087013;52776.736116319174;53147;75999;77148.2285177141;90809;76710.61644691853;78181;78971;79259.60370198112;79895.20104798993;43943.56056439459;52638.47361526412;66161.33838661648;69781.65109174422;72495;8439.620217090369;8447.788805279917;8584.184502472255;8647;8726;37318.440223397214;38408.61591384162;42449.5755042458;44029.77985110054;44773.32840007338;37796.62203377931;40906.79546602248;60628;62367;62952.370476296484;10568.89431105679;10667.733306667395;10812;11445.828312575151;11531.423428828693;12212.87787122153;12436.564720234748;12659.959557630524;13028.478860845838;13280;11837.940810295893;11963.342016189194;12083.456244468844;12779;12798.872011279767;11340.432978351215;11537.59618413385;11546.364949927834;11937.3434461102;12032.217905836093;10467.738306542398;10526.789464210826;11163.665090047312;11289.153313501356;11555.42222888869;9147.542622868697;9175.587098580447;9266.934302555022;9372.34393592442;9726.659566915125;8931.19619234272;9093.318001150072;9118.77203069902;9187.002350048177;9428.15146636806 02:58:23 INFO - PROCESS | 3471 | __end_tp_report 02:58:23 INFO - PROCESS | 3471 | __start_cc_report 02:58:23 INFO - PROCESS | 3471 | _x_x_mozilla_cycle_collect,392 02:58:23 INFO - PROCESS | 3471 | __end_cc_report 02:58:23 INFO - PROCESS | 3471 | __startTimestamp1465811903090__endTimestamp 02:58:23 INFO - PROCESS | 3471 | 02:58:23 INFO - PROCESS | 3471 | ------- Summary: start ------- 02:58:23 INFO - PROCESS | 3471 | Number of tests: 6 02:58:23 INFO - PROCESS | 3471 | 02:58:23 INFO - PROCESS | 3471 | [#0] dojo.html Cycles:165 Average:4816.16 Median:4966.65 stddev:608.42 (12.3%) stddev-sans-first:585.67 02:58:23 INFO - PROCESS | 3471 | Values: 2632.3 2702.3 2718.6 2719.1 2725.1 4851.8 4895.0 4918.6 4988.2 5036.0 4765.3 4887.0 4909.3 4916.4 4978.0 4477.8 4521.0 4632.3 4634.3 4647.6 586.1 4471.3 4494.6 4572.1 4627.4 4524.2 4535.8 4540.2 4561.5 4587.9 4417.2 4565.6 4584.5 4586.9 4607.0 4477.1 4491.3 4495.2 4499.0 4532.0 4923.0 4932.4 4966.2 4966.7 4983.7 5185.8 5250.1 5284.3 5313.3 5374.6 5313.6 5313.7 5320.6 5323.3 5366.6 4946.8 4951.2 4952.0 4959.5 4962.4 5200.3 5271.7 5301.5 5334.2 5380.4 5082.1 5102.1 5109.6 5111.6 5124.8 5198.8 5205.8 5219.7 5225.2 5258.8 5068.2 5116.2 5158.4 5184.9 5187.4 5037.9 5044.6 5055.1 5069.7 5105.1 4324.1 4340.3 4345.4 4350.4 4391.7 3789.2 3868.9 3901.9 3926.2 3941.5 4494.9 4521.4 4522.4 4558.4 4560.1 5109.8 5313.1 5331.4 5337.2 5358.9 4403.1 4470.0 4473.7 4482.4 4483.4 4718.5 4726.6 4731.2 4746.7 4760.6 4785.3 4914.7 4918.9 4924.7 4959.1 5297.4 5333.4 5350.3 5359.9 5414.2 4936.4 4938.3 4948.5 4952.7 4978.5 4998.7 5125.4 5142.1 5185.8 5246.9 5246.8 5263.5 5265.6 5299.2 5303.9 5115.3 5119.4 5124.9 5151.4 5164.1 4928.0 4971.7 4974.8 4991.0 5130.4 4948.5 4999.7 5025.5 5046.8 5081.7 5131.5 5139.4 5152.0 5158.3 5228.5 4742.7 4833.8 4986.5 5041.7 5047.9 02:58:23 INFO - PROCESS | 3471 | 02:58:23 INFO - PROCESS | 3471 | [#1] ext.html Cycles:180 Average:53256.32 Median:37632.31 stddev:114486.78 (304.2%) stddev-sans-first:114739.51 02:58:23 INFO - PROCESS | 3471 | Values: 535.3 575.4 591.1 595.1 605.8 34948.7 40914.6 40973.8 41016.2 41113.6 40355.0 41060.2 41477.4 41485.8 41505.8 7801.9 7875.3 7901.6 7951.3 7967.5 7739.3 7797.5 7825.0 7837.8 7840.3 7832.3 7869.8 7884.4 7888.4 7895.8 7817.3 7829.8 7842.8 7847.0 7849.4 7803.1 7821.8 7845.9 7857.6 7858.9 38114.0 38263.6 38302.6 38548.8 38586.0 3203.9 3206.2 3220.9 3252.8 3512.5 29923.7 29942.3 30178.8 30194.7 30942.5 3207.6 3248.4 3265.3 3265.5 3274.6 244089.0 247240.0 247467.0 249437.0 250069.0 31873.0 32874.3 48405.0 48451.8 48490.0 33807.3 33988.7 34104.1 34224.3 34437.8 12633.4 12716.6 12790.9 12804.6 12825.0 10591.9 10653.8 10706.9 10730.5 10750.5 7814.8 7846.4 7901.5 7919.9 7939.2 3121.4 3121.5 3133.9 3170.0 3179.9 852.5 898.7 902.5 973.5 978.7 27999.9 28080.6 28495.9 28547.3 28926.9 921.2 1004.9 1021.1 1034.7 1053.0 14072.6 14150.7 14373.9 14492.6 14505.8 385955.0 624324.0 639508.0 639527.0 639721.0 51080.0 51218.0 51750.5 51787.7 52086.2 1188.4 1215.1 1220.9 1224.5 1225.9 28302.7 29253.4 29491.9 29891.9 30063.0 44118.1 44794.8 44967.0 44979.0 45116.8 359675.0 363868.0 364377.0 364785.0 365871.0 25762.2 25883.4 26392.6 26397.6 26429.5 43394.6 43930.8 44050.8 44313.0 44722.8 37603.8 38135.2 38181.0 38195.6 38449.0 36680.3 38061.4 38090.4 38097.0 38255.6 32827.7 36345.6 37660.8 37866.2 37910.4 32151.5 33301.2 33853.7 33932.0 34122.0 25047.2 25395.9 25664.4 25854.5 26302.7 02:58:23 INFO - PROCESS | 3471 | 02:58:23 INFO - PROCESS | 3471 | [#2] jquery.html Cycles:180 Average:25042.44 Median:4720.17 stddev:67528.12 (1430.6%) stddev-sans-first:67692.16 02:58:23 INFO - PROCESS | 3471 | Values: 377.5 377.7 382.2 396.7 399.2 15529.4 16292.4 16520.3 16766.3 16906.4 15497.8 16308.0 16360.5 16386.2 17032.5 4630.5 4788.7 4800.5 4806.0 4841.4 3533.0 5217.8 5501.9 5504.7 5577.1 5522.6 5558.6 5574.0 5586.4 5636.0 6051.7 6057.3 6068.5 6072.8 6075.3 4651.7 4932.8 5457.2 5466.0 5474.3 19673.5 20052.3 20501.8 20610.6 20643.6 1888.2 1908.0 1970.5 1995.7 2004.5 8973.0 9145.5 9258.6 9487.1 12016.8 1604.5 1674.2 1687.7 1690.7 1719.1 68619.0 70279.6 70680.0 71011.3 71085.3 9347.3 9371.9 9398.7 9415.3 9918.8 12392.0 12524.4 12538.1 12572.2 12763.2 7014.8 7026.6 7100.5 7163.0 7274.6 6779.8 6785.6 6922.8 6923.1 6929.7 4178.0 4188.6 4285.4 4357.9 4425.7 1686.4 1754.8 1834.8 1848.8 1893.4 843.3 862.4 919.9 935.1 938.1 15276.5 16686.3 18273.4 18525.4 18913.7 806.4 839.3 846.7 862.6 911.2 9331.5 9739.2 9790.9 9844.3 9970.0 405398.0 407097.0 408329.0 409956.0 411187.0 80344.0 81500.2 82626.6 84418.0 84710.0 908.6 959.9 964.2 968.8 976.9 14774.3 14843.0 14903.3 14983.4 15137.4 37462.0 37627.2 37710.8 37746.0 37785.0 48786.0 54821.0 55710.7 56040.2 56530.2 6717.7 7133.9 7202.2 7365.3 7616.8 8843.0 11312.2 11450.0 11891.6 11962.7 10097.7 10269.0 10443.6 10469.6 10521.4 10442.7 10467.4 10780.6 10940.8 10991.1 10349.2 10497.5 10574.5 10586.3 10697.8 6652.3 8016.2 8152.5 8159.1 8163.1 8412.7 9817.3 10029.1 10171.9 10402.8 02:58:23 INFO - PROCESS | 3471 | 02:58:23 INFO - PROCESS | 3471 | [#3] mootools.html Cycles:180 Average:5262.04 Median:5228.41 stddev:2981.54 (57.0%) stddev-sans-first:2975.73 02:58:23 INFO - PROCESS | 3471 | Values: 1392.5 1413.1 1466.7 1645.4 1653.7 6936.9 7623.5 7631.0 8174.1 8200.2 7726.0 7977.2 8039.2 8072.7 8077.9 2193.0 2220.0 2222.8 2231.3 2235.0 2160.2 2177.1 2202.3 2217.8 2219.1 2193.3 2198.3 2212.2 2213.2 2249.5 2138.5 2140.9 2141.9 2144.9 2150.7 2148.5 2183.1 2188.0 2191.5 2195.9 8067.1 8075.8 8099.3 8147.2 8177.5 4602.4 4758.7 4765.7 4783.2 4794.4 2871.9 2917.1 2970.2 2980.1 2999.7 843.1 862.6 892.5 899.4 900.9 11254.4 11286.8 11301.7 11326.2 11338.8 4224.7 4245.4 4304.4 4310.3 4416.4 9379.8 9391.3 9483.9 9504.2 9509.0 4730.8 4738.7 4760.2 4767.0 4772.0 3682.3 4180.6 4280.6 4322.7 4331.8 3725.4 3733.5 3794.4 3821.3 3845.7 1186.5 1203.6 1210.4 1215.3 1223.7 708.5 828.0 848.6 858.7 869.4 5039.4 5282.9 5382.4 5496.2 5543.6 872.2 884.9 906.1 907.9 911.8 3727.6 3740.4 3770.2 3775.2 3834.7 9667.0 9840.0 9938.4 10065.4 10098.7 9913.6 9938.9 9996.7 10020.6 10055.9 7204.7 7488.0 7494.7 7532.9 7550.7 5188.6 5268.2 5317.9 5394.2 5441.9 9088.4 9131.9 9148.8 9176.5 9187.3 9020.2 9173.4 9283.5 9307.2 9371.3 5768.6 6109.3 6356.6 6361.0 6417.4 7622.2 7660.4 7684.2 7747.6 7770.7 6803.0 7072.3 7084.1 7121.3 7209.5 6675.0 6718.7 6905.2 6939.4 7159.0 6333.1 6360.2 6363.6 6393.4 6422.6 4669.6 4684.8 4698.0 4755.8 4766.8 4757.1 4783.5 4807.3 4828.3 4852.2 02:58:23 INFO - PROCESS | 3471 | 02:58:23 INFO - PROCESS | 3471 | [#4] prototype.html Cycles:180 Average:4428.97 Median:5056.44 stddev:1277.32 (25.3%) stddev-sans-first:1242.61 02:58:23 INFO - PROCESS | 3471 | Values: 293.1 298.5 299.5 300.9 302.4 5021.5 5058.2 5103.7 5120.0 5140.1 5015.9 5038.3 5054.6 5054.7 5075.7 3745.6 3829.2 3897.6 3965.4 3973.4 3894.3 3931.2 3942.1 3949.6 3964.4 3949.9 3957.9 3967.1 3972.2 3976.7 3900.9 3939.8 3968.0 3968.2 3996.8 3450.7 3502.7 3506.4 3523.0 3525.9 4878.0 4889.0 4894.6 4922.4 4923.5 4407.8 4553.6 4573.9 4597.3 4606.5 5270.3 5273.6 5290.6 5309.1 5315.7 3844.6 3850.0 3854.2 3856.9 3858.6 5398.3 5499.9 5577.3 5582.9 5619.2 3973.4 3984.3 3998.9 4010.6 4027.0 4072.5 4073.0 4074.8 4075.6 4083.9 4553.1 4562.4 4578.2 4589.1 4591.9 5067.7 5330.0 5332.6 5354.5 5354.9 1386.4 1403.0 1408.5 1409.4 1416.4 867.0 883.3 884.4 919.9 924.8 4453.7 4572.9 4585.0 4658.8 4665.8 5394.5 5454.2 5468.4 5561.9 5574.8 4419.0 4568.9 4585.5 4593.3 4596.2 2889.3 2915.7 2918.7 2924.9 2946.4 5085.9 5107.2 5110.9 5132.8 5147.7 5428.9 5478.9 5572.5 5582.0 5586.2 5063.2 5119.4 5125.4 5142.2 5143.8 5501.9 5520.8 5523.4 5531.1 5553.3 5172.0 5372.3 5390.8 5407.3 5410.9 5080.3 5087.7 5125.4 5138.8 5139.2 3982.6 4022.2 4051.1 4051.5 4059.3 5325.7 5531.7 5545.6 5550.3 5585.2 5284.7 5307.4 5315.4 5353.8 5412.4 5257.7 5262.3 5284.5 5298.4 5343.5 4989.0 5345.8 5363.5 5364.5 5386.2 5225.9 5274.8 5397.4 5429.9 5469.0 5233.5 5244.0 5270.9 5319.3 5330.5 02:58:23 INFO - PROCESS | 3471 | 02:58:23 INFO - PROCESS | 3471 | [#5] yui.html Cycles:180 Average:16019.18 Median:52961.87 stddev:21651.40 (40.9%) stddev-sans-first:21681.36 02:58:23 INFO - PROCESS | 3471 | Values: 644.3 695.4 713.3 738.2 780.3 12569.4 12674.8 12679.1 12719.8 12904.2 12519.1 13182.3 13205.7 13453.6 13454.5 624.5 794.6 800.3 802.1 802.6 772.3 793.5 793.9 797.6 800.1 835.6 835.9 839.5 841.6 841.9 829.7 830.1 830.5 831.5 834.8 604.0 605.2 606.1 607.4 609.8 12579.6 12691.2 12706.8 12752.1 12759.3 12457.3 12555.8 12743.7 12841.4 13264.1 10474.2 10541.6 10601.9 10760.2 10772.8 3224.2 3316.2 3361.1 3367.4 3368.4 61312.0 62201.0 63145.0 63759.4 63825.0 9734.2 9917.3 9919.3 9953.4 10040.7 17888.2 17939.8 17948.2 17958.7 18072.5 6782.1 6954.5 7022.4 7055.9 7069.4 3695.7 3837.0 3893.8 3920.4 3995.4 3029.7 3106.8 3120.5 3123.4 3136.1 497.7 505.0 508.9 515.0 523.8 543.6 572.5 574.9 585.8 594.4 6898.4 7029.7 7230.5 7232.9 7406.4 567.2 567.4 570.2 574.0 585.5 3600.7 3674.6 3699.8 3701.3 3753.4 52776.7 53147.0 75999.0 77148.2 90809.0 76710.6 78181.0 78971.0 79259.6 79895.2 43943.6 52638.5 66161.3 69781.7 72495.0 8439.6 8447.8 8584.2 8647.0 8726.0 37318.4 38408.6 42449.6 44029.8 44773.3 37796.6 40906.8 60628.0 62367.0 62952.4 10568.9 10667.7 10812.0 11445.8 11531.4 12212.9 12436.6 12660.0 13028.5 13280.0 11837.9 11963.3 12083.5 12779.0 12798.9 11340.4 11537.6 11546.4 11937.3 12032.2 10467.7 10526.8 11163.7 11289.2 11555.4 9147.5 9175.6 9266.9 9372.3 9726.7 8931.2 9093.3 9118.8 9187.0 9428.2 02:58:23 INFO - PROCESS | 3471 | -------- Summary: end -------- 02:58:23 INFO - PROCESS | 3471 | 02:58:23 INFO - TEST-INFO | 3471: exit 0 02:58:23 INFO - TEST-OK | dromaeo_css | took 1117616ms 02:58:23 INFO - TEST-START | kraken 02:58:23 INFO - operating with platform_type : linux_ 02:58:23 INFO - Initialising browser for kraken test... 02:58:23 INFO - TEST-INFO | started process 3703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmCu5ne/profile http://localhost:59477/getInfo.html) 02:58:28 INFO - PROCESS | 3703 | __metrics Screen width/height:1600/1200 02:58:28 INFO - PROCESS | 3703 | colorDepth:24 02:58:28 INFO - PROCESS | 3703 | Browser inner width/height: 1024/697 02:58:28 INFO - PROCESS | 3703 | __metrics 02:58:29 ERROR - PROCESS | 3703 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:58:30 INFO - TEST-INFO | 3703: exit 0 02:58:30 INFO - Browser initialized. 02:58:30 INFO - Running cycle 1/1 for kraken test... 02:58:30 INFO - TEST-INFO | started process 3821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmCu5ne/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:42 INFO - PROCESS | 3821 | RSS: Main: 185487360 02:58:42 INFO - PROCESS | 3821 | 02:58:45 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59477/tests/kraken/driver.html?testName=audio-beat-detection) 02:58:46 INFO - PROCESS | 3821 | RSS: Main: 190369792 02:58:46 INFO - PROCESS | 3821 | 02:58:49 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59477/tests/kraken/driver.html?testName=audio-dft) 02:58:49 INFO - PROCESS | 3821 | RSS: Main: 189947904 02:58:49 INFO - PROCESS | 3821 | 02:58:52 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59477/tests/kraken/driver.html?testName=audio-fft) 02:58:53 INFO - PROCESS | 3821 | RSS: Main: 185708544 02:58:53 INFO - PROCESS | 3821 | 02:58:55 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59477/tests/kraken/driver.html?testName=audio-oscillator) 02:58:56 INFO - PROCESS | 3821 | RSS: Main: 186257408 02:58:56 INFO - PROCESS | 3821 | 02:58:58 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59477/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:58:59 INFO - PROCESS | 3821 | RSS: Main: 186552320 02:58:59 INFO - PROCESS | 3821 | 02:59:02 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59477/tests/kraken/driver.html?testName=imaging-darkroom) 02:59:02 INFO - PROCESS | 3821 | RSS: Main: 186900480 02:59:02 INFO - PROCESS | 3821 | 02:59:06 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59477/tests/kraken/driver.html?testName=imaging-desaturate) 02:59:06 INFO - PROCESS | 3821 | RSS: Main: 183922688 02:59:06 INFO - PROCESS | 3821 | 02:59:09 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59477/tests/kraken/driver.html?testName=json-parse-financial) 02:59:10 INFO - PROCESS | 3821 | RSS: Main: 186179584 02:59:10 INFO - PROCESS | 3821 | 02:59:12 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59477/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:59:12 INFO - PROCESS | 3821 | RSS: Main: 186003456 02:59:12 INFO - PROCESS | 3821 | 02:59:14 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59477/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:59:15 INFO - PROCESS | 3821 | RSS: Main: 186413056 02:59:15 INFO - PROCESS | 3821 | 02:59:17 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59477/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:59:18 INFO - PROCESS | 3821 | RSS: Main: 186650624 02:59:18 INFO - PROCESS | 3821 | 02:59:21 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:59:21 INFO - PROCESS | 3821 | RSS: Main: 186699776 02:59:21 INFO - PROCESS | 3821 | 02:59:24 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:59:25 INFO - PROCESS | 3821 | RSS: Main: 186884096 02:59:25 INFO - PROCESS | 3821 | 02:59:27 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:59477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59477/tests/kraken/driver.html?testName=ai-astar) 02:59:27 INFO - PROCESS | 3821 | RSS: Main: 188166144 02:59:27 INFO - PROCESS | 3821 | 02:59:27 INFO - PROCESS | 3821 | __start_tp_report 02:59:27 INFO - PROCESS | 3821 | _x_x_mozilla_page_load 02:59:27 INFO - PROCESS | 3821 | _x_x_mozilla_page_load_details 02:59:27 INFO - PROCESS | 3821 | |i|pagename|runs| 02:59:27 INFO - PROCESS | 3821 | |0;ai-astar;114;107;115;116;114;114;112;115;112;114 02:59:27 INFO - PROCESS | 3821 | |1;audio-beat-detection;162;133;154;182;131;162;159;131;183;136 02:59:27 INFO - PROCESS | 3821 | |2;audio-dft;162;168;173;163;163;162;161;165;161;160 02:59:27 INFO - PROCESS | 3821 | |3;audio-fft;76;76;76;164;77;76;75;76;162;76 02:59:27 INFO - PROCESS | 3821 | |4;audio-oscillator;87;86;151;87;86;86;138;87;86;141 02:59:27 INFO - PROCESS | 3821 | |5;imaging-gaussian-blur;118;118;118;117;117;117;119;117;117;118 02:59:27 INFO - PROCESS | 3821 | |6;imaging-darkroom;147;150;147;147;147;148;148;149;148;147 02:59:27 INFO - PROCESS | 3821 | |7;imaging-desaturate;96;95;96;96;96;97;95;96;95;96 02:59:27 INFO - PROCESS | 3821 | |8;json-parse-financial;62;63;63;62;63;62;63;64;62;63 02:59:27 INFO - PROCESS | 3821 | |9;json-stringify-tinderbox;66;66;66;67;65;65;65;69;66;65 02:59:27 INFO - PROCESS | 3821 | |10;stanford-crypto-aes;89;83;88;86;85;83;87;85;108;90 02:59:27 INFO - PROCESS | 3821 | |11;stanford-crypto-ccm;133;132;134;134;135;130;132;134;160;142 02:59:27 INFO - PROCESS | 3821 | |12;stanford-crypto-pbkdf2;170;169;168;177;169;169;168;166;167;170 02:59:27 INFO - PROCESS | 3821 | |13;stanford-crypto-sha256-iterative;73;73;67;68;68;67;67;68;66;66 02:59:27 INFO - PROCESS | 3821 | __end_tp_report 02:59:27 INFO - PROCESS | 3821 | __start_cc_report 02:59:27 INFO - PROCESS | 3821 | _x_x_mozilla_cycle_collect,983 02:59:27 INFO - PROCESS | 3821 | __end_cc_report 02:59:27 INFO - PROCESS | 3821 | __startTimestamp1465811967310__endTimestamp 02:59:27 INFO - PROCESS | 3821 | 02:59:27 INFO - PROCESS | 3821 | ------- Summary: start ------- 02:59:27 INFO - PROCESS | 3821 | Number of tests: 14 02:59:27 INFO - PROCESS | 3821 | 02:59:27 INFO - PROCESS | 3821 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:2.54 (2.2%) stddev-sans-first:2.68 02:59:27 INFO - PROCESS | 3821 | Values: 114.0 107.0 115.0 116.0 114.0 114.0 112.0 115.0 112.0 114.0 02:59:27 INFO - PROCESS | 3821 | 02:59:27 INFO - PROCESS | 3821 | [#1] audio-beat-detection Cycles:10 Average:153.30 Median:160.50 stddev:19.99 (12.5%) stddev-sans-first:20.95 02:59:27 INFO - PROCESS | 3821 | Values: 162.0 133.0 154.0 182.0 131.0 162.0 159.0 131.0 183.0 136.0 02:59:27 INFO - PROCESS | 3821 | 02:59:27 INFO - PROCESS | 3821 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:3.97 (2.4%) stddev-sans-first:4.15 02:59:27 INFO - PROCESS | 3821 | Values: 162.0 168.0 173.0 163.0 163.0 162.0 161.0 165.0 161.0 160.0 02:59:27 INFO - PROCESS | 3821 | 02:59:27 INFO - PROCESS | 3821 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:36.69 (48.3%) stddev-sans-first:38.37 02:59:27 INFO - PROCESS | 3821 | Values: 76.0 76.0 76.0 164.0 77.0 76.0 75.0 76.0 162.0 76.0 02:59:27 INFO - PROCESS | 3821 | 02:59:27 INFO - PROCESS | 3821 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:86.00 stddev:27.68 (32.2%) stddev-sans-first:28.71 02:59:27 INFO - PROCESS | 3821 | Values: 87.0 86.0 151.0 87.0 86.0 86.0 138.0 87.0 86.0 141.0 02:59:27 INFO - PROCESS | 3821 | 02:59:27 INFO - PROCESS | 3821 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 02:59:27 INFO - PROCESS | 3821 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 119.0 117.0 117.0 118.0 02:59:27 INFO - PROCESS | 3821 | 02:59:27 INFO - PROCESS | 3821 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 02:59:27 INFO - PROCESS | 3821 | Values: 147.0 150.0 147.0 147.0 147.0 148.0 148.0 149.0 148.0 147.0 02:59:27 INFO - PROCESS | 3821 | 02:59:27 INFO - PROCESS | 3821 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 02:59:27 INFO - PROCESS | 3821 | Values: 96.0 95.0 96.0 96.0 96.0 97.0 95.0 96.0 95.0 96.0 02:59:27 INFO - PROCESS | 3821 | 02:59:27 INFO - PROCESS | 3821 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 02:59:27 INFO - PROCESS | 3821 | Values: 62.0 63.0 63.0 62.0 63.0 62.0 63.0 64.0 62.0 63.0 02:59:27 INFO - PROCESS | 3821 | 02:59:27 INFO - PROCESS | 3821 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:1.25 (1.9%) stddev-sans-first:1.32 02:59:27 INFO - PROCESS | 3821 | Values: 66.0 66.0 66.0 67.0 65.0 65.0 65.0 69.0 66.0 65.0 02:59:27 INFO - PROCESS | 3821 | 02:59:27 INFO - PROCESS | 3821 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:86.50 stddev:7.28 (8.4%) stddev-sans-first:7.71 02:59:27 INFO - PROCESS | 3821 | Values: 89.0 83.0 88.0 86.0 85.0 83.0 87.0 85.0 108.0 90.0 02:59:27 INFO - PROCESS | 3821 | 02:59:27 INFO - PROCESS | 3821 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:134.00 stddev:8.81 (6.6%) stddev-sans-first:9.25 02:59:27 INFO - PROCESS | 3821 | Values: 133.0 132.0 134.0 134.0 135.0 130.0 132.0 134.0 160.0 142.0 02:59:27 INFO - PROCESS | 3821 | 02:59:27 INFO - PROCESS | 3821 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:169.00 stddev:2.98 (1.8%) stddev-sans-first:3.15 02:59:27 INFO - PROCESS | 3821 | Values: 170.0 169.0 168.0 177.0 169.0 169.0 168.0 166.0 167.0 170.0 02:59:27 INFO - PROCESS | 3821 | 02:59:27 INFO - PROCESS | 3821 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:2.58 (3.8%) stddev-sans-first:2.11 02:59:27 INFO - PROCESS | 3821 | Values: 73.0 73.0 67.0 68.0 68.0 67.0 67.0 68.0 66.0 66.0 02:59:27 INFO - PROCESS | 3821 | -------- Summary: end -------- 02:59:27 INFO - PROCESS | 3821 | 02:59:28 INFO - TEST-INFO | 3821: exit 0 02:59:28 INFO - TEST-OK | kraken | took 64506ms 02:59:28 INFO - SUITE-END | took 1182s 02:59:28 INFO - Completed test suite (00:19:42) 02:59:28 INFO - javascript benchmark 02:59:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6441.850954746174, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2632.3419145213697, 2702.2974026753045, 2718.592211168326, 2719.1434698070107, 2725.1415804021744, 4851.80592776289, 4894.951050489494, 4918.606511479077, 4988.176950803113, 5036.043151801156, 4765.261384485401, 4887.0, 4909.263610458433, 4916.410030796309, 4978.004399120181, 4477.798499067541, 4521.0, 4632.281996290563, 4634.281686338623, 4647.55848194421, 586.0541152675911, 4471.262241730111, 4494.550544945512, 4572.131295053946, 4627.375304333906, 4524.208263553898, 4535.841245556389, 4540.228161212602, 4561.475430325522, 4587.885302867422, 4417.160739459492, 4565.589096981287, 4584.518625544337, 4586.862394128181, 4607.0325231701045, 4477.059817438342, 4491.25894227452, 4495.23580991229, 4498.977505112486, 4532.0, 4922.950770492321, 4932.383452068491, 4966.15575352191, 4966.652334336598, 4983.72589507577, 5185.766640501187, 5250.081235783722, 5284.286621306152, 5313.335833020872, 5374.596905232123, 5313.628046036779, 5313.654612450178, 5320.6275560710765, 5323.254744335796, 5366.597505187126, 4946.826861059882, 4951.183054795991, 4951.9752401237765, 4959.528844759778, 4962.354893863775, 5200.323957885526, 5271.710055946883, 5301.496357845998, 5334.199870019528, 5380.408155102936, 5082.1360368737405, 5102.107131252016, 5109.642325037212, 5111.591072714174, 5124.846254612367, 5198.792048318025, 5205.7917683293, 5219.686818790885, 5225.190095535198, 5258.789648414097, 5068.189089745623, 5116.2069879168785, 5158.432572417031, 5184.870378240499, 5187.351581052369, 5037.899242015213, 5044.571211447068, 5055.115354812893, 5069.721165335942, 5105.081085404663, 4324.0919406924895, 4340.327249276367, 4345.391645169679, 4350.434443522385, 4391.692581519263, 3789.204267103884, 3868.8839334819436, 3901.882943511699, 3926.155876486569, 3941.5270167580074, 4494.910101798011, 4521.389612402284, 4522.389477420506, 4558.407407037131, 4560.1335746208115, 5109.821156259513, 5313.123334649739, 5331.413544510101, 5337.172738225581, 5358.91961620576, 4403.119376124788, 4469.9776501117285, 4473.731576105444, 4482.39487669167, 4483.394741709827, 4718.528147185322, 4726.550977657117, 4731.243001119804, 4746.69146505483, 4760.619150468024, 4785.330053792542, 4914.729689867092, 4918.901621967612, 4924.704517728947, 4959.082569724613, 5297.364316282071, 5333.359996800409, 5350.277712508917, 5359.919601205907, 5414.242006119068, 4936.358273424432, 4938.2839488273285, 4948.480409556944, 4952.653314268111, 4978.5270399312, 4998.650094493496, 5125.410577783603, 5142.100132476727, 5185.844424667266, 5246.871922536673, 5246.842594722164, 5263.473652634706, 5265.631405801557, 5299.205119232146, 5303.9204411934625, 5115.283860259641, 5119.385673719177, 5124.948750512447, 5151.381834179922, 5164.147915593885, 4928.0, 4971.726555039363, 4974.801007959641, 4990.975045124751, 5130.384353877409, 4948.529889660476, 4999.675021123615, 5025.522575355335, 5046.77289521965, 5081.695098294114, 5131.461196574306, 5139.383274006994, 5152.0, 5158.277841102324, 5228.503292187236, 4742.715437073786, 4833.830815921426, 4986.526280003394, 5041.6722913010535, 5047.924281135859], "value": 4779.23651620021, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.3343977953532, 575.4360726488042, 591.0779184472221, 595.1370512756503, 605.7849463440476, 34948.65051349486, 40914.59085409145, 40973.7951310243, 41016.17967640646, 41113.58886411135, 40355.0, 41060.17879642405, 41477.37783933243, 41485.79257103718, 41505.792471037676, 7801.92198078019, 7875.251851074138, 7901.644426000815, 7951.284384405402, 7967.521948683097, 7739.303462688357, 7797.532148071134, 7825.0218722659665, 7837.764867053969, 7840.255175758322, 7832.295093441589, 7869.803254918645, 7884.448088633798, 7888.408369372291, 7895.8420831583335, 7817.335526480256, 7829.843403131934, 7842.764717058469, 7847.0, 7849.411294152905, 7803.102643196048, 7821.765347039598, 7845.882311765328, 7857.607119643995, 7858.921410785876, 38114.0, 38263.617363826284, 38302.61697383018, 38548.807255963824, 38586.0, 3203.9038828835173, 3206.198450387403, 3220.9355812883846, 3252.788568743024, 3512.525809015776, 29923.70076299253, 29942.25144371408, 30178.84910575455, 30194.698053019627, 30942.53586196209, 3207.631122420928, 3248.3990461764647, 3265.297960938386, 3265.510173473974, 3274.590676165479, 244089.0, 247240.0, 247467.0, 249436.9999999982, 250069.0, 31873.0, 32874.342513150084, 48405.0, 48451.75774121107, 48490.0, 33807.323853522794, 33988.66011339904, 34104.14739631529, 34224.31551368959, 34437.827810860785, 12633.431495582721, 12716.554920577735, 12790.936045319713, 12804.61586152417, 12825.0, 10591.94704026475, 10653.84019239712, 10706.89293107059, 10730.517126729315, 10750.462476876124, 7814.804629884298, 7846.372290216769, 7901.525908445512, 7919.881201781978, 7939.2060793920145, 3121.438141134572, 3121.5161649944293, 3133.905982820519, 3169.9683003170135, 3179.856906439216, 852.4885068958575, 898.6589933223988, 902.5081330674798, 973.5035132082547, 978.6574698855486, 27999.860000699868, 28080.578791318145, 28495.857520712263, 28547.286317841805, 28926.855365723037, 921.2077613252598, 1004.9045340692622, 1021.0657248617432, 1034.7413146713322, 1052.9894701052892, 14072.577822665336, 14150.716985660229, 14373.928130359282, 14492.565223043326, 14505.782413263809, 385955.0, 624324.0, 639508.0, 639527.0, 639721.0, 51080.0, 51218.0, 51750.48249517532, 51787.74106129445, 52086.21870671943, 1188.3701638131804, 1215.1008253892055, 1220.8840160184768, 1224.4918358881143, 1225.926444413338, 28302.716972830007, 29253.41493170167, 29491.85254073802, 29891.850540748026, 30063.0, 44118.11763764771, 44794.77602611966, 44967.0, 44979.0, 45116.77441612771, 359675.0, 363868.0, 364377.0, 364785.0, 365871.0, 25762.227133186036, 25883.352916176493, 26392.604110937966, 26397.604035939094, 26429.471410572067, 43394.566054339055, 43930.780346099345, 44050.77974610106, 44313.0, 44722.77638611786, 37603.81198093992, 38135.2372952545, 38181.0, 38195.618043820316, 38449.0, 36680.26639467249, 38061.42907856329, 38090.42864357092, 38097.04757380977, 38255.617443825206, 32827.67172328342, 36345.636543634224, 37660.811695941346, 37866.24267514579, 37910.43134353042, 32151.517727233644, 33301.16747081342, 33853.66146338505, 33932.0, 34122.0, 25047.248582542554, 25395.87302063478, 25664.358391040372, 25854.482910342063, 26302.736972630028], "value": 16859.15274701742, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.5107202087765, 377.66576579726944, 382.2336215887146, 396.6588733689025, 399.16574359588475, 15529.378824847006, 16292.429764958244, 16520.339186432528, 16766.329346826144, 16906.40827571034, 15497.845021549781, 16308.0, 16360.509184724448, 16386.180690965433, 17032.48902532923, 4630.536946305368, 4788.664793464459, 4800.495947925452, 4805.951940480603, 4841.443234028079, 3532.982335088321, 5217.765200565965, 5501.889962200754, 5504.669719816804, 5577.107662773957, 5522.641028333165, 5558.610897237195, 5574.0, 5586.441355864401, 5635.971820140914, 6051.727672254715, 6057.3336932937345, 6068.544859135561, 6072.817815465543, 6075.301340345873, 4651.674382793206, 4932.8273510427325, 5457.2359869618285, 5466.043442397565, 5474.315710536183, 19673.508162295915, 20052.298169563994, 20501.794982050287, 20610.587788244302, 20643.587128257503, 1888.2447021191497, 1908.0, 1970.458124015907, 1995.7305763722002, 2004.4587961250381, 8973.0, 9145.451272923647, 9258.583363748647, 9487.098725621125, 12016.759664806656, 1604.4945842059715, 1674.2047527424497, 1687.7468379743013, 1690.6956747785393, 1719.0983403517464, 68619.0, 70279.64860175666, 70680.0, 71011.28988710098, 71085.2891471089, 9347.252219822398, 9371.906280937239, 9398.718038458857, 9415.293852960918, 9918.817860070772, 12392.0, 12524.373781310898, 12538.059645526622, 12572.182808117443, 12763.170393924365, 7014.824629384306, 7026.578405295699, 7100.502964792415, 7162.964185179041, 7274.599897005715, 6779.796606101825, 6785.55893866907, 6922.826929326807, 6923.065386172903, 6929.688164032631, 4178.0, 4188.6230239278, 4285.421468101828, 4357.934630980538, 4425.668074894395, 1686.3928985565433, 1754.7894252689503, 1834.7711013601606, 1848.778146622414, 1893.4035778729656, 843.3000609494105, 862.4394143806451, 919.9402038867452, 935.1350001248818, 938.0853667674099, 15276.541703748682, 16686.33254669824, 18273.3604323848, 18525.351612693492, 18913.7162942556, 806.3871457692196, 839.2740279658174, 846.6994217052858, 862.5859587398085, 911.2345629671108, 9331.486768227813, 9739.220862330996, 9790.902090979142, 9844.310898237054, 9969.950150249202, 405398.0, 407097.0, 408329.0, 409956.0, 411187.0, 80344.0, 81500.18499814926, 82626.58686706529, 84418.0, 84710.0, 908.5593487158723, 959.9280053995979, 964.238251781099, 968.7674958010168, 976.8925418203992, 14774.33515491827, 14843.0, 14903.254837258311, 14983.40066397332, 15137.394504219708, 37462.0, 37627.2474550502, 37710.81144594259, 37745.98032157366, 37785.0, 48786.0, 54821.0, 55710.72144639251, 56040.15939760825, 56530.15204772014, 6717.697703603448, 7133.928660713326, 7202.207757146605, 7365.2634736525915, 7616.8476630468185, 8842.955785221033, 11312.20814543007, 11450.0, 11891.643250702493, 11962.700932476757, 10097.747556310856, 10269.0, 10443.634472793416, 10469.633562825264, 10521.421321827373, 10442.68671939843, 10467.424291664032, 10780.622678206226, 10940.835887461535, 10991.120710342993, 10349.172066234834, 10497.52761125736, 10574.471276436301, 10586.311889727143, 10697.786044279226, 6652.301508341748, 8016.238457346542, 8152.510849349058, 8159.102498725017, 8163.102058773649, 8412.747617571482, 9817.31278810505, 10029.147522460673, 10171.949140254252, 10402.791944160923], "value": 8214.987874233126, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1392.519580744643, 1413.1168019987508, 1466.6919946811176, 1645.3583102589992, 1653.669266146771, 6936.9306306936915, 7623.54258744475, 7631.0, 8174.059983101945, 8200.220979006992, 7726.0, 7977.20227977202, 8039.2362725541125, 8072.677092916291, 8077.8788318175275, 2192.9780702192975, 2219.9889000554977, 2222.75549689534, 2231.3306008197555, 2234.955300893981, 2160.157538559963, 2177.096504950444, 2202.284257616273, 2217.833662475313, 2219.1345375303645, 2193.3310340346266, 2198.3404978506383, 2212.1593794358123, 2213.1700612270397, 2249.460129568908, 2138.4653836540942, 2140.9357719268446, 2141.8929053547417, 2144.9463763405884, 2150.7204063471804, 2148.52732398872, 2183.0503730877117, 2187.9781202187933, 2191.5178660694623, 2195.9451013724624, 8067.112617612058, 8075.798105047362, 8099.311558517533, 8147.226013528764, 8177.509349438993, 4602.447706275235, 4758.666893317469, 4765.69023013503, 4783.1868582341085, 4794.376731024944, 2871.9086747036204, 2917.124862541229, 2970.2425881400322, 2980.135760629415, 2999.7150270724246, 843.1273631791128, 862.5773371048203, 892.5403417240127, 899.419874181156, 900.9144131307515, 11254.43727813606, 11286.830697539626, 11301.717457063556, 11326.15053870963, 11338.829917551244, 4224.725392849455, 4245.3844192591905, 4304.397384366192, 4310.31035034393, 4416.447944006999, 9379.812403751886, 9391.29565282593, 9483.857742133874, 9504.192143667728, 9509.0, 4730.763461826964, 4738.691985020962, 4760.214564596803, 4766.95233047672, 4771.95228047715, 3682.2819550187455, 4180.644645205191, 4280.5505421930875, 4322.7190232634775, 4331.761753103609, 3725.385311423585, 3733.5146430964346, 3794.392897136445, 3821.3312670283144, 3845.65389114981, 1186.4516805568815, 1203.602811072344, 1210.4250481021445, 1215.2708374974945, 1223.6757259326287, 708.4721882197796, 828.0394742099136, 848.5757121439281, 858.686579398515, 869.3914260018013, 5039.420466646309, 5282.894342113136, 5382.434844341366, 5496.1755736639825, 5543.584231182677, 872.2062922740275, 884.9203971155181, 906.0971958886417, 907.9092090791, 911.7811725185908, 3727.552693676776, 3740.401535754266, 3770.245950809794, 3775.2260786538695, 3834.731568790158, 9666.95166524163, 9840.0, 9938.403695778277, 10065.446400448045, 10098.697039088838, 9913.603455861828, 9938.850917236103, 9996.700098997042, 10020.64927727526, 10055.949720251352, 7204.711811527585, 7487.9891214687495, 7494.700211991569, 7532.887006694904, 7550.6602202901, 5188.610854186027, 5268.209768534751, 5317.867053323698, 5394.163904594794, 5441.863953401196, 9088.363814532919, 9131.863022054808, 9148.817023659623, 9176.541172941194, 9187.265018798615, 9020.233280171258, 9173.44959302444, 9283.48940808235, 9307.20888724439, 9371.344005919793, 5768.567357448292, 6109.266887973472, 6356.586821856565, 6361.0, 6417.39034791694, 7622.199669034671, 7660.387169026576, 7684.193159718149, 7747.573883436465, 7770.689172433039, 6803.0, 7072.257412971564, 7084.07906972111, 7121.287871212838, 7209.531380460253, 6674.966625166843, 6718.6976586054725, 6905.1713794345, 6939.410150137295, 7158.964205179149, 6333.113364128933, 6360.204974378203, 6363.5545511813725, 6393.360663933756, 6422.6467544285515, 4669.579737823612, 4684.812607495662, 4698.0, 4755.83354582588, 4766.833160839354, 4757.072370887644, 4783.4738178801, 4807.278908163804, 4828.348172996601, 4852.223644216909], "value": 4219.3537674145255, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.0841121495327, 298.48511317976494, 299.54469206805663, 300.8540857684024, 302.37861195243767, 5021.548060674539, 5058.165402708549, 5103.693778373291, 5119.974400127999, 5140.074786538422, 5015.949840501594, 5038.345015148035, 5054.609982254872, 5054.721990290533, 5075.74621268936, 3745.614122774577, 3829.1767270036935, 3897.610238976108, 3965.3655415133585, 3973.384125460558, 3894.2600905827944, 3931.174453364797, 3942.1327307992196, 3949.605039496056, 3964.405339199114, 3949.9012524686827, 3957.881263562098, 3967.0875698589343, 3972.245273398045, 3976.6619837313865, 3900.8829735107706, 3939.8030098495246, 3968.047668559525, 3968.226195891788, 3996.8001599920035, 3450.6721861423125, 3502.667246611568, 3506.3870619515055, 3523.0, 3525.894223173283, 4878.0, 4889.046635906, 4894.559489645949, 4922.384701912261, 4923.507649235084, 4407.779611019469, 4553.612942899857, 4573.862784116482, 4597.287420449836, 4606.5393460654, 5270.288511050997, 5273.551748101416, 5290.603204759658, 5309.062192299822, 5315.681059136464, 3844.615538446161, 3850.0, 3854.1713531590844, 3856.903577410559, 3858.5723282385416, 5398.272552783111, 5499.862503437406, 5577.3028371453565, 5582.944170558283, 5619.241402410663, 3973.4238535412205, 3984.2629113614075, 3998.9400158997637, 4010.5588385277597, 4026.979865100656, 4072.470578824734, 4072.9838729828925, 4074.7555146691293, 4075.633193012643, 4083.85706500277, 4553.134904368159, 4562.406887104655, 4578.153041687298, 4589.059242855206, 4591.9081618367445, 5067.746612669425, 5330.0, 5332.626716129911, 5354.491323324278, 5354.8661283467445, 1386.3692020130816, 1402.9649258768613, 1408.507022542102, 1409.4080486195821, 1416.362636813438, 866.9956650216709, 883.2845395229884, 884.3544212724747, 919.8804155459748, 924.7734305095161, 4453.665975051884, 4572.862814115582, 4584.991301913574, 4658.836940707059, 4665.836695715634, 5394.487523685244, 5454.209139674725, 5468.433857728762, 5561.886483136383, 5574.777008919679, 4418.961544037149, 4568.880624247081, 4585.495595484494, 4593.28804035375, 4596.241620132708, 2889.2632378743288, 2915.7230063144393, 2918.7227213415117, 2924.8830046798316, 2946.36653119576, 5085.949140508622, 5107.208382700687, 5110.948890511122, 5132.769025393866, 5147.716875571879, 5428.864278393072, 5478.863028424242, 5572.5263352614675, 5581.972090139605, 5586.229295225707, 5063.215201643678, 5119.385673719177, 5125.410577783603, 5142.1772516397195, 5143.8456846294675, 5501.917471237854, 5520.834374968757, 5523.447655234444, 5531.142672885549, 5553.250311207935, 5171.974140129275, 5372.328458942632, 5390.838274851761, 5407.324084489439, 5410.864728381822, 5080.298100136348, 5087.720175390389, 5125.411122552021, 5138.794448222179, 5139.229115632685, 3982.6415622594104, 4022.1553473770837, 4051.149258655715, 4051.5340735815757, 4059.3099173141227, 5325.680459172462, 5531.695756733418, 5545.639533430314, 5550.27846379968, 5585.162225666182, 5284.656497327662, 5307.416184219655, 5315.352240805362, 5353.839384818461, 5412.377576578744, 5257.740201075358, 5262.289590905332, 5284.471552844685, 5298.390685071112, 5343.477109023909, 4989.027139707722, 5345.759440825094, 5363.463653634762, 5364.5171934524515, 5386.192071189353, 5225.92161117576, 5274.839535302227, 5397.382269599319, 5429.864253393696, 5468.960897429476, 5233.450487698889, 5243.973780131075, 5270.920936185884, 5319.335083114611, 5330.466953304794], "value": 4017.969840522072, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.3266786208412, 695.4332219241321, 713.333033613571, 738.2138023005499, 780.3094261578505, 12569.434375453104, 12674.809877851829, 12679.112462127632, 12719.809202861952, 12904.161229520074, 12519.123661343687, 13182.340882955838, 13205.669858253548, 13453.596392108228, 13454.5290914818, 624.4660815003175, 794.5987276425398, 800.2877439079224, 802.1296892871242, 802.5906787538369, 772.308783638643, 793.5238856686, 793.9206079392044, 797.6490344248512, 800.139849661616, 835.6156168162653, 835.8955130608674, 839.5172775653992, 841.6423020216414, 841.8863453433769, 829.6805729794013, 830.1325115254574, 830.464350493928, 831.501099340397, 834.7579202031465, 603.9547033972469, 605.1799811255773, 606.066657347684, 607.3713706313988, 609.8048624440181, 12579.622611321674, 12691.175073620278, 12706.809397859039, 12752.10735248533, 12759.298238596873, 12457.252564846047, 12555.811662825065, 12743.681407964783, 12841.357932103358, 13264.137831040951, 10474.21443391741, 10541.631042913461, 10601.946990265, 10760.154458670308, 10772.814990351055, 3224.210068533201, 3316.1543806329473, 3361.1429085583018, 3367.3770352484867, 3368.360011597789, 61312.0, 62201.0, 63145.0, 63759.36240637627, 63825.04262436067, 9734.221262299, 9917.30578859473, 9919.305648604528, 9953.353032052893, 10040.69877903664, 17888.195031223626, 17939.820601793814, 17948.192331345123, 17958.730619040725, 18072.457826265232, 6782.118324617768, 6954.513184077167, 7022.438204943593, 7055.858882822417, 7069.434445244368, 3695.7412981091065, 3837.0407398150464, 3893.766374017568, 3920.3531417316394, 3995.380715989026, 3029.6515900671707, 3106.8446577671025, 3120.453920563892, 3123.4377811993604, 3136.090533745234, 497.6640767481935, 504.9596032317406, 508.8524327944855, 515.0008982573795, 523.8349919775259, 543.5570010441556, 572.5419664268569, 574.8821491594213, 585.809611876142, 594.3551246897078, 6898.379145876896, 7029.718811247595, 7230.493865429369, 7232.891506627405, 7406.444516661164, 567.2398985359638, 567.3617180671745, 570.2216474512261, 574.0442163797231, 585.5110982329717, 3600.7299452541165, 3674.632536746304, 3699.7595156314756, 3701.296753616858, 3753.399456087013, 52776.736116319174, 53147.0, 75999.0, 77148.2285177141, 90809.0, 76710.61644691853, 78181.0, 78971.0, 79259.60370198112, 79895.20104798993, 43943.56056439459, 52638.47361526412, 66161.33838661648, 69781.65109174422, 72495.0, 8439.620217090369, 8447.788805279917, 8584.184502472255, 8647.0, 8726.0, 37318.440223397214, 38408.61591384162, 42449.5755042458, 44029.77985110054, 44773.32840007338, 37796.62203377931, 40906.79546602248, 60628.0, 62367.0, 62952.370476296484, 10568.89431105679, 10667.733306667395, 10812.0, 11445.828312575151, 11531.423428828693, 12212.87787122153, 12436.564720234748, 12659.959557630524, 13028.478860845838, 13280.0, 11837.940810295893, 11963.342016189194, 12083.456244468844, 12779.0, 12798.872011279767, 11340.432978351215, 11537.59618413385, 11546.364949927834, 11937.3434461102, 12032.217905836093, 10467.738306542398, 10526.789464210826, 11163.665090047312, 11289.153313501356, 11555.42222888869, 9147.542622868697, 9175.587098580447, 9266.934302555022, 9372.34393592442, 9726.659566915125, 8931.19619234272, 9093.318001150072, 9118.77203069902, 9187.002350048177, 9428.15146636806], "value": 6367.457059553544, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 115.0, 116.0, 114.0, 114.0, 112.0, 115.0, 112.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 133.0, 154.0, 182.0, 131.0, 162.0, 159.0, 131.0, 183.0, 136.0], "value": 153.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 173.0, 163.0, 163.0, 162.0, 161.0, 165.0, 161.0, 160.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 164.0, 77.0, 76.0, 75.0, 76.0, 162.0, 76.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 151.0, 87.0, 86.0, 86.0, 138.0, 87.0, 86.0, 141.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 150.0, 147.0, 147.0, 147.0, 148.0, 148.0, 149.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 63.0, 62.0, 63.0, 64.0, 62.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 65.0, 65.0, 65.0, 69.0, 66.0, 65.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 88.0, 86.0, 85.0, 83.0, 87.0, 85.0, 108.0, 90.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 134.0, 134.0, 135.0, 130.0, 132.0, 134.0, 160.0, 142.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 168.0, 177.0, 169.0, 169.0, 168.0, 166.0, 167.0, 170.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 67.0, 68.0, 68.0, 67.0, 67.0, 68.0, 66.0, 66.0], "value": 68.3, "unit": "score"}]}]} 02:59:28 INFO - Return code: 0 02:59:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:59:28 ERROR - # TBPL SUCCESS # 02:59:28 INFO - Running post-action listener: _resource_record_post_action 02:59:28 INFO - ##### 02:59:28 INFO - ##### Finished run-tests step (success) 02:59:28 INFO - ##### 02:59:28 INFO - Running post-run listener: _resource_record_post_run 02:59:28 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7647232; Write bytes: 439357440; Read time: 1324; Write time: 408512 02:59:28 INFO - TinderboxPrint: CPU usage
13.4% 02:59:28 INFO - TinderboxPrint: I/O read bytes / time
7,647,232 / 1,324 02:59:28 INFO - TinderboxPrint: I/O write bytes / time
439,357,440 / 408,512 02:59:28 INFO - TinderboxPrint: CPU idle
8,285.7 (86.6%) 02:59:28 INFO - TinderboxPrint: CPU user
1,230.4 (12.9%) 02:59:28 INFO - TinderboxPrint: Swap in / out
0 / 0 02:59:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5316608; Read time: 0; Write time: 468 02:59:28 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 5885952; Write bytes: 376381440; Read time: 1044; Write time: 363988 02:59:29 INFO - Running post-run listener: _upload_blobber_files 02:59:29 INFO - Blob upload gear active. 02:59:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:59:29 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 02:59:29 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:59:29 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:59:29 INFO - (blobuploader) - INFO - Open directory for files ... 02:59:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:59:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:59:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:30 INFO - (blobuploader) - INFO - Done attempting. 02:59:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:59:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:59:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:31 INFO - (blobuploader) - INFO - Done attempting. 02:59:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:59:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:59:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:59:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:59:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:59:36 INFO - (blobuploader) - INFO - Done attempting. 02:59:36 INFO - (blobuploader) - INFO - Iteration through files over. 02:59:36 INFO - Return code: 0 02:59:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:59:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:59:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de4c33c9eb5b1c00ccdf151b02d3e27eff7174692d75186a304b49a16ddf455eea4676f7fb0a01aba9fc4c6c43dab20b2cc3b1dfe11886aab76ef55a6201816a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a4e15d49a9f6e9697a349d53f7ee2e702bfcfc1e98551186e61c178d6aaea8aed9c95c6e0e2d1485ff7a25787497f003dcd57495268b51ec006faf162a5c2ddc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d5ba0363dd02de21ed0f3e3a382e064a572ae1d39862e052924dd475ec12a57af6542324fff91ddb5a9f2ed656c64f97607feb7f9661e24c42e93557cd83cbd1"} 02:59:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:59:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:59:36 INFO - Contents: 02:59:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de4c33c9eb5b1c00ccdf151b02d3e27eff7174692d75186a304b49a16ddf455eea4676f7fb0a01aba9fc4c6c43dab20b2cc3b1dfe11886aab76ef55a6201816a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a4e15d49a9f6e9697a349d53f7ee2e702bfcfc1e98551186e61c178d6aaea8aed9c95c6e0e2d1485ff7a25787497f003dcd57495268b51ec006faf162a5c2ddc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d5ba0363dd02de21ed0f3e3a382e064a572ae1d39862e052924dd475ec12a57af6542324fff91ddb5a9f2ed656c64f97607feb7f9661e24c42e93557cd83cbd1"} 02:59:36 INFO - Running post-run listener: copy_logs_to_upload_dir 02:59:36 INFO - Copying logs to upload dir... 02:59:36 INFO - mkdir: /builds/slave/test/build/upload/logs 02:59:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.050057 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-06-13 02:59:36.067769) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 02:59:36.071746) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779 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-Non-PGO/sha512/de4c33c9eb5b1c00ccdf151b02d3e27eff7174692d75186a304b49a16ddf455eea4676f7fb0a01aba9fc4c6c43dab20b2cc3b1dfe11886aab76ef55a6201816a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a4e15d49a9f6e9697a349d53f7ee2e702bfcfc1e98551186e61c178d6aaea8aed9c95c6e0e2d1485ff7a25787497f003dcd57495268b51ec006faf162a5c2ddc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d5ba0363dd02de21ed0f3e3a382e064a572ae1d39862e052924dd475ec12a57af6542324fff91ddb5a9f2ed656c64f97607feb7f9661e24c42e93557cd83cbd1"} build_url:https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011164 build_url: 'https://queue.taskcluster.net/v1/task/BbWLE156ReK2Lk-OM1klXA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de4c33c9eb5b1c00ccdf151b02d3e27eff7174692d75186a304b49a16ddf455eea4676f7fb0a01aba9fc4c6c43dab20b2cc3b1dfe11886aab76ef55a6201816a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a4e15d49a9f6e9697a349d53f7ee2e702bfcfc1e98551186e61c178d6aaea8aed9c95c6e0e2d1485ff7a25787497f003dcd57495268b51ec006faf162a5c2ddc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d5ba0363dd02de21ed0f3e3a382e064a572ae1d39862e052924dd475ec12a57af6542324fff91ddb5a9f2ed656c64f97607feb7f9661e24c42e93557cd83cbd1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 02:59:36.096850) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 02:59:36.097206) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1465799769.515492-331790779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004357 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 02:59:36.180342) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 02:59:36.180652) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 02:59:36.180951) ========= ========= Total master_lag: 0.18 =========