builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-016 starttime: 1467123251.57 results: success (0) buildid: 20160628063121 builduid: 10b9406dd4cc4cddb2f25d90c22bd986 revision: 6b8a1c9c02517bb47d61eadece83273863cb32d5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 07:14:11.571527) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 07:14:11.571981) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 07:14:11.572268) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 07:14:11.644135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:14:11.644524) ========= 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=00204705a9daa57ed339a427000001b9-1467123250.97943-534840665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 07:14:12-- 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% 5.34M=0.002s 2016-06-28 07:14:12 (5.34 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078993 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:14:11.738334) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:14:11.738643) ========= 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=00204705a9daa57ed339a427000001b9-1467123250.97943-534840665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015655 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:14:11.787744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:14:11.788122) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6b8a1c9c02517bb47d61eadece83273863cb32d5 --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 6b8a1c9c02517bb47d61eadece83273863cb32d5 --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=00204705a9daa57ed339a427000001b9-1467123250.97943-534840665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 07:14:12,206 truncating revision to first 12 chars 2016-06-28 07:14:12,206 Setting DEBUG logging. 2016-06-28 07:14:12,206 attempt 1/10 2016-06-28 07:14:12,206 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6b8a1c9c0251?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 07:14:12,538 unpacking tar archive at: fx-team-6b8a1c9c0251/testing/mozharness/ program finished with exit code 0 elapsedTime=0.682207 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:14:12.483629) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 07:14:12.483929) ========= script_repo_revision: 6b8a1c9c02517bb47d61eadece83273863cb32d5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 07:14:12.484364) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 07:14:12.484627) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 07:14:12.493641) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-28 07:14:12.493921) ========= /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=00204705a9daa57ed339a427000001b9-1467123250.97943-534840665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:14:12 INFO - MultiFileLogger online at 20160628 07:14:12 in /builds/slave/test 07:14:12 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 07:14:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:14:12 INFO - {'append_to_log': False, 07:14:12 INFO - 'base_work_dir': '/builds/slave/test', 07:14:12 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:14:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:14:12 INFO - 'branch': 'Fx-Team-Non-PGO', 07:14:12 INFO - 'buildbot_json_path': 'buildprops.json', 07:14:12 INFO - 'config_files': ('talos/linux_config.py',), 07:14:12 INFO - 'default_actions': ('clobber', 07:14:12 INFO - 'read-buildbot-config', 07:14:12 INFO - 'download-and-extract', 07:14:12 INFO - 'populate-webroot', 07:14:12 INFO - 'create-virtualenv', 07:14:12 INFO - 'install', 07:14:12 INFO - 'run-tests'), 07:14:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:14:12 INFO - 'download_minidump_stackwalk': True, 07:14:12 INFO - 'download_symbols': 'ondemand', 07:14:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:14:12 INFO - 'tooltool.py': '/tools/tooltool.py', 07:14:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:14:12 INFO - '/tools/misc-python/virtualenv.py')}, 07:14:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:14:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:14:12 INFO - 'installer_path': 'installer.exe', 07:14:12 INFO - 'log_level': 'info', 07:14:12 INFO - 'log_name': 'talos', 07:14:12 INFO - 'log_to_console': True, 07:14:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:14:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:14:12 INFO - 'opt_config_files': (), 07:14:12 INFO - 'pip_index': False, 07:14:12 INFO - 'sps_profile': False, 07:14:12 INFO - 'sps_profile_interval': 0, 07:14:12 INFO - 'suite': 'dromaeojs-e10s', 07:14:12 INFO - 'system_bits': '32', 07:14:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:14:12 INFO - 'title': 'talos-linux64-ix-016', 07:14:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:14:12 INFO - 'use_talos_json': True, 07:14:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:14:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:14:12 INFO - 'work_dir': 'build'} 07:14:12 INFO - ##### 07:14:12 INFO - ##### Running clobber step. 07:14:12 INFO - ##### 07:14:12 INFO - Running pre-action listener: _resource_record_pre_action 07:14:12 INFO - Running main action method: clobber 07:14:12 INFO - rmtree: /builds/slave/test/build 07:14:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:14:13 INFO - Running post-action listener: _resource_record_post_action 07:14:13 INFO - ##### 07:14:13 INFO - ##### Finished clobber step (success) 07:14:13 INFO - ##### 07:14:13 INFO - ##### 07:14:13 INFO - ##### Running read-buildbot-config step. 07:14:13 INFO - ##### 07:14:13 INFO - Running pre-action listener: _resource_record_pre_action 07:14:13 INFO - Running main action method: read_buildbot_config 07:14:13 INFO - Using buildbot properties: 07:14:13 INFO - { 07:14:13 INFO - "project": "", 07:14:13 INFO - "product": "firefox", 07:14:13 INFO - "script_repo_revision": "production", 07:14:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:14:13 INFO - "repository": "", 07:14:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:14:13 INFO - "buildid": "20160628063121", 07:14:13 INFO - "pgo_build": "False", 07:14:13 INFO - "basedir": "/builds/slave/test", 07:14:13 INFO - "buildnumber": 1619, 07:14:13 INFO - "slavename": "talos-linux64-ix-016", 07:14:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:14:13 INFO - "platform": "ubuntu64_hw", 07:14:13 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:14:13 INFO - "branch": "fx-team", 07:14:13 INFO - "repo_path": "integration/fx-team", 07:14:13 INFO - "revision": "6b8a1c9c02517bb47d61eadece83273863cb32d5", 07:14:13 INFO - "stage_platform": "linux64", 07:14:13 INFO - "builduid": "10b9406dd4cc4cddb2f25d90c22bd986", 07:14:13 INFO - "slavebuilddir": "test" 07:14:13 INFO - } 07:14:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:14:13 INFO - Running post-action listener: _resource_record_post_action 07:14:13 INFO - ##### 07:14:13 INFO - ##### Finished read-buildbot-config step (success) 07:14:13 INFO - ##### 07:14:13 INFO - ##### 07:14:13 INFO - ##### Running download-and-extract step. 07:14:13 INFO - ##### 07:14:13 INFO - Running pre-action listener: _resource_record_pre_action 07:14:13 INFO - Running main action method: download_and_extract 07:14:13 INFO - mkdir: /builds/slave/test/build/tests 07:14:13 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')]} 07:14:13 INFO - https://queue.taskcluster.net/v1/task/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:14:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:14:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:14:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/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 07:14:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/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 07:14:14 INFO - Downloaded 1361 bytes. 07:14:14 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:14:14 INFO - Using the following test package requirements: 07:14:14 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:14:14 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:14:14 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:14:14 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:14 INFO - u'jsshell-linux-x86_64.zip'], 07:14:14 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:14:14 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:14:14 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:14:14 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:14:14 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:14:14 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:14:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:14: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')]} 07:14:14 INFO - https://queue.taskcluster.net/v1/task/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:14:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:14:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:14:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/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 07:14:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/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 07:14:15 INFO - Downloaded 22713365 bytes. 07:14:15 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'] 07:14:15 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 07:14:16 INFO - Return code: 0 07:14:16 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 07:14:16 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')]} 07:14:16 INFO - https://queue.taskcluster.net/v1/task/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:14:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:14:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:14:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/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 07:14:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/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 07:14:17 INFO - Downloaded 22713365 bytes. 07:14:17 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'] 07:14:17 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 07:14:19 INFO - Return code: 0 07:14:19 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')]} 07:14:19 INFO - https://queue.taskcluster.net/v1/task/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:14:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:14:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:14:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/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 07:14:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/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 07:14:20 INFO - Downloaded 14405245 bytes. 07:14:20 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'] 07:14:20 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 07:14:20 INFO - Return code: 0 07:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:14:20 INFO - https://queue.taskcluster.net/v1/task/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:14:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:14:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:14:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/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 07:14:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QPK3yCBNTNSF6qK4_QuP2g/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 07:14:22 INFO - Downloaded 56398245 bytes. 07:14:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:14:22 INFO - mkdir: /builds/slave/test/properties 07:14:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:14:22 INFO - Writing to file /builds/slave/test/properties/build_url 07:14:22 INFO - Contents: 07:14:22 INFO - build_url:https://queue.taskcluster.net/v1/task/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:14:22 INFO - Running post-action listener: _resource_record_post_action 07:14:22 INFO - Running post-action listener: set_extra_try_arguments 07:14:22 INFO - ##### 07:14:22 INFO - ##### Finished download-and-extract step (success) 07:14:22 INFO - ##### 07:14:22 INFO - ##### 07:14:22 INFO - ##### Running populate-webroot step. 07:14:22 INFO - ##### 07:14:22 INFO - Running pre-action listener: _resource_record_pre_action 07:14:22 INFO - Running main action method: populate_webroot 07:14:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:14:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:14:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:14:22 INFO - '--tppagecycles', 07:14:22 INFO - '7'], 07:14:22 INFO - 'tests': ['tsvgm']}}, 07:14:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:14:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:14:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:14:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:14:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:14:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:14:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:22 INFO - 'talos_options': ['--disable-e10s'], 07:14:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:22 INFO - 'talos_options': ['--disable-e10s'], 07:14:22 INFO - 'tests': ['damp', 'tps']}, 07:14:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:22 INFO - 'tests': ['damp', 'tps']}, 07:14:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:14:22 INFO - 'tests': ['dromaeo_dom']}, 07:14:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:14:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:14:22 INFO - 'tests': ['basic_compositor_video']}, 07:14:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:14:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:14:22 INFO - 'tests': ['a11yr', 07:14:22 INFO - 'ts_paint', 07:14:22 INFO - 'tpaint', 07:14:22 INFO - 'sessionrestore', 07:14:22 INFO - 'sessionrestore_no_auto_restore', 07:14:22 INFO - 'tabpaint']}, 07:14:22 INFO - 'other-e10s': {'tests': ['a11yr', 07:14:22 INFO - 'ts_paint', 07:14:22 INFO - 'tpaint', 07:14:22 INFO - 'sessionrestore', 07:14:22 INFO - 'sessionrestore_no_auto_restore', 07:14:22 INFO - 'tabpaint']}, 07:14:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:14:22 INFO - 'ts_paint', 07:14:22 INFO - 'tpaint', 07:14:22 INFO - 'sessionrestore', 07:14:22 INFO - 'sessionrestore_no_auto_restore', 07:14:22 INFO - 'tabpaint']}, 07:14:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:14:22 INFO - 'ts_paint', 07:14:22 INFO - 'tpaint', 07:14:22 INFO - 'sessionrestore', 07:14:22 INFO - 'sessionrestore_no_auto_restore', 07:14:22 INFO - 'tabpaint']}, 07:14:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:14:22 INFO - 'tests': ['a11yr', 07:14:22 INFO - 'ts_paint', 07:14:22 INFO - 'tpaint', 07:14:22 INFO - 'sessionrestore', 07:14:22 INFO - 'sessionrestore_no_auto_restore', 07:14:22 INFO - 'tabpaint']}, 07:14:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:14:22 INFO - 'tests': ['a11yr', 07:14:22 INFO - 'ts_paint', 07:14:22 INFO - 'tpaint', 07:14:22 INFO - 'sessionrestore', 07:14:22 INFO - 'sessionrestore_no_auto_restore', 07:14:22 INFO - 'tabpaint']}, 07:14:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:14:22 INFO - 'tests': ['tsvgx', 07:14:22 INFO - 'tsvgr_opacity', 07:14:22 INFO - 'tart', 07:14:22 INFO - 'tscrollx', 07:14:22 INFO - 'cart']}, 07:14:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:14:22 INFO - 'tsvgr_opacity', 07:14:22 INFO - 'tart', 07:14:22 INFO - 'tscrollx', 07:14:22 INFO - 'cart']}, 07:14:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:22 INFO - 'talos_options': ['--disable-e10s'], 07:14:22 INFO - 'tests': ['tp5o']}, 07:14:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:22 INFO - 'tests': ['tp5o']}, 07:14:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:22 INFO - 'talos_options': ['--disable-e10s', 07:14:22 INFO - '--xperf_path', 07:14:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:22 INFO - 'tests': ['tp5n']}, 07:14:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:22 INFO - 'talos_options': ['--xperf_path', 07:14:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:22 INFO - 'tests': ['tp5n']}}, 07:14:22 INFO - 'talos.zip': {'path': '', 07:14:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:14:22 INFO - Running post-action listener: _resource_record_post_action 07:14:22 INFO - ##### 07:14:22 INFO - ##### Finished populate-webroot step (success) 07:14:22 INFO - ##### 07:14:22 INFO - ##### 07:14:22 INFO - ##### Running create-virtualenv step. 07:14:22 INFO - ##### 07:14:22 INFO - Running pre-action listener: _resource_record_pre_action 07:14:22 INFO - Running main action method: create_virtualenv 07:14:22 INFO - Creating virtualenv /builds/slave/test/build/venv 07:14:22 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 07:14:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:14:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:14:22 INFO - Using real prefix '/usr' 07:14:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:14:23 INFO - Installing distribute.............................................................................................................................................................................................done. 07:14:25 INFO - Installing pip.................done. 07:14:25 INFO - Return code: 0 07:14:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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')]} 07:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f714ba38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc710>, '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 0x12dd610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ddaa0>, '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': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', '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 07:14: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', 'pip>=1.5'] in /builds/slave/test/build 07:14: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 pip>=1.5 07:14:25 INFO - Using env: {'DISPLAY': ':0', 07:14:25 INFO - 'HOME': '/home/cltbld', 07:14:25 INFO - 'LANG': 'en_US.UTF-8', 07:14:25 INFO - 'LANGUAGE': 'en_US:en', 07:14:25 INFO - 'LOGNAME': 'cltbld', 07:14:25 INFO - 'MAIL': '/var/mail/cltbld', 07:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:25 INFO - 'MOZ_NO_REMOTE': '1', 07:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:25 INFO - 'NO_EM_RESTART': '1', 07:14:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:25 INFO - 'PWD': '/builds/slave/test', 07:14:25 INFO - 'SHELL': '/bin/bash', 07:14:25 INFO - 'SHLVL': '1', 07:14:25 INFO - 'TERM': 'linux', 07:14:25 INFO - 'TMOUT': '86400', 07:14:25 INFO - 'USER': 'cltbld', 07:14:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', 07:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:25 INFO - '_': '/tools/buildbot/bin/python'} 07:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:25 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 07:14:25 INFO - Cleaning up... 07:14:25 INFO - Return code: 0 07:14:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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')]} 07:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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', '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 0x7f714ba38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc710>, '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 0x12dd610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ddaa0>, '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': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', '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 07:14: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:14: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 psutil>=3.1.1 07:14:25 INFO - Using env: {'DISPLAY': ':0', 07:14:25 INFO - 'HOME': '/home/cltbld', 07:14:25 INFO - 'LANG': 'en_US.UTF-8', 07:14:25 INFO - 'LANGUAGE': 'en_US:en', 07:14:25 INFO - 'LOGNAME': 'cltbld', 07:14:25 INFO - 'MAIL': '/var/mail/cltbld', 07:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:25 INFO - 'MOZ_NO_REMOTE': '1', 07:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:25 INFO - 'NO_EM_RESTART': '1', 07:14:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:25 INFO - 'PWD': '/builds/slave/test', 07:14:25 INFO - 'SHELL': '/bin/bash', 07:14:25 INFO - 'SHLVL': '1', 07:14:25 INFO - 'TERM': 'linux', 07:14:25 INFO - 'TMOUT': '86400', 07:14:25 INFO - 'USER': 'cltbld', 07:14:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', 07:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:25 INFO - '_': '/tools/buildbot/bin/python'} 07:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:25 INFO - Downloading/unpacking psutil>=3.1.1 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:14:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:14:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:14:27 INFO - Installing collected packages: psutil 07:14:27 INFO - Running setup.py install for psutil 07:14:27 INFO - building 'psutil._psutil_linux' extension 07:14:27 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 07:14:28 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 07:14:28 INFO - building 'psutil._psutil_posix' extension 07:14:28 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 07:14:28 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 07:14:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:14:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:14:28 INFO - Successfully installed psutil 07:14:28 INFO - Cleaning up... 07:14:28 INFO - Return code: 0 07:14:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:14:28 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')]} 07:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:28 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')]} 07:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:28 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 0x7f714ba38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc710>, '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 0x12dd610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ddaa0>, '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': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', '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 07:14:28 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 07:14:28 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 07:14:28 INFO - Using env: {'DISPLAY': ':0', 07:14:28 INFO - 'HOME': '/home/cltbld', 07:14:28 INFO - 'LANG': 'en_US.UTF-8', 07:14:28 INFO - 'LANGUAGE': 'en_US:en', 07:14:28 INFO - 'LOGNAME': 'cltbld', 07:14:28 INFO - 'MAIL': '/var/mail/cltbld', 07:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:28 INFO - 'MOZ_NO_REMOTE': '1', 07:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:28 INFO - 'NO_EM_RESTART': '1', 07:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:28 INFO - 'PWD': '/builds/slave/test', 07:14:28 INFO - 'SHELL': '/bin/bash', 07:14:28 INFO - 'SHLVL': '1', 07:14:28 INFO - 'TERM': 'linux', 07:14:28 INFO - 'TMOUT': '86400', 07:14:28 INFO - 'USER': 'cltbld', 07:14:28 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', 07:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:28 INFO - '_': '/tools/buildbot/bin/python'} 07:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:14:28 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 07:14:28 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 07:14:28 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 07:14:28 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 07:14:28 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 07:14:28 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 07:14:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:14:30 INFO - Installing collected packages: mozsystemmonitor 07:14:30 INFO - Running setup.py install for mozsystemmonitor 07:14:30 INFO - Successfully installed mozsystemmonitor 07:14:30 INFO - Cleaning up... 07:14:30 INFO - Return code: 0 07:14:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:30 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 0x7f714ba38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc710>, '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 0x12dd610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ddaa0>, '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': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', '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 07:14:30 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 07:14:30 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 07:14:30 INFO - Using env: {'DISPLAY': ':0', 07:14:30 INFO - 'HOME': '/home/cltbld', 07:14:30 INFO - 'LANG': 'en_US.UTF-8', 07:14:30 INFO - 'LANGUAGE': 'en_US:en', 07:14:30 INFO - 'LOGNAME': 'cltbld', 07:14:30 INFO - 'MAIL': '/var/mail/cltbld', 07:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:30 INFO - 'MOZ_NO_REMOTE': '1', 07:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:30 INFO - 'NO_EM_RESTART': '1', 07:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:30 INFO - 'PWD': '/builds/slave/test', 07:14:30 INFO - 'SHELL': '/bin/bash', 07:14:30 INFO - 'SHLVL': '1', 07:14:30 INFO - 'TERM': 'linux', 07:14:30 INFO - 'TMOUT': '86400', 07:14:30 INFO - 'USER': 'cltbld', 07:14:30 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', 07:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:30 INFO - '_': '/tools/buildbot/bin/python'} 07:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:30 INFO - Downloading/unpacking jsonschema==2.5.1 07:14:30 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 07:14:30 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 07:14:30 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 07:14:30 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 07:14:30 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 07:14:30 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 07:14:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:14:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:14:32 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 07:14:32 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 07:14:32 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 07:14:32 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 07:14:32 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 07:14:32 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 07:14:32 INFO - Downloading functools32-3.2.3-2.tar.gz 07:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:14:33 INFO - warning: no files found matching '*.txt' 07:14:33 INFO - no previously-included directories found matching 'build' 07:14:33 INFO - no previously-included directories found matching 'dist' 07:14:33 INFO - no previously-included directories found matching '.git*' 07:14:33 INFO - Installing collected packages: jsonschema, functools32 07:14:33 INFO - Running setup.py install for functools32 07:14:33 INFO - warning: no files found matching '*.txt' 07:14:33 INFO - no previously-included directories found matching 'build' 07:14:33 INFO - no previously-included directories found matching 'dist' 07:14:33 INFO - no previously-included directories found matching '.git*' 07:14:33 INFO - Successfully installed jsonschema functools32 07:14:33 INFO - Cleaning up... 07:14:33 INFO - Return code: 0 07:14:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:33 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 0x7f714ba38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc710>, '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 0x12dd610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ddaa0>, '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': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', '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 07:14:33 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 07:14:33 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 07:14:33 INFO - Using env: {'DISPLAY': ':0', 07:14:33 INFO - 'HOME': '/home/cltbld', 07:14:33 INFO - 'LANG': 'en_US.UTF-8', 07:14:33 INFO - 'LANGUAGE': 'en_US:en', 07:14:33 INFO - 'LOGNAME': 'cltbld', 07:14:33 INFO - 'MAIL': '/var/mail/cltbld', 07:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:33 INFO - 'MOZ_NO_REMOTE': '1', 07:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:33 INFO - 'NO_EM_RESTART': '1', 07:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:33 INFO - 'PWD': '/builds/slave/test', 07:14:33 INFO - 'SHELL': '/bin/bash', 07:14:33 INFO - 'SHLVL': '1', 07:14:33 INFO - 'TERM': 'linux', 07:14:33 INFO - 'TMOUT': '86400', 07:14:33 INFO - 'USER': 'cltbld', 07:14:33 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', 07:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:33 INFO - '_': '/tools/buildbot/bin/python'} 07:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:33 INFO - Downloading/unpacking blobuploader==1.2.4 07:14:33 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 07:14:33 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 07:14:33 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 07:14:33 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 07:14:33 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 07:14:33 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 07:14:35 INFO - Downloading blobuploader-1.2.4.tar.gz 07:14:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:14:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:14:35 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 07:14:35 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 07:14:35 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 07:14:35 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 07:14:35 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 07:14:35 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 07:14:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:14:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:14:35 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 07:14:35 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 07:14:35 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 07:14:35 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 07:14:35 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 07:14:35 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 07:14:36 INFO - Downloading docopt-0.6.1.tar.gz 07:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:14:36 INFO - Installing collected packages: blobuploader, requests, docopt 07:14:36 INFO - Running setup.py install for blobuploader 07:14:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:14:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:14:36 INFO - Running setup.py install for requests 07:14:36 INFO - Running setup.py install for docopt 07:14:36 INFO - Successfully installed blobuploader requests docopt 07:14:36 INFO - Cleaning up... 07:14:36 INFO - Return code: 0 07:14:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:36 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')]} 07:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:36 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')]} 07:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:36 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 0x7f714ba38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc710>, '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 0x12dd610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ddaa0>, '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': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', '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 07:14:36 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 07:14:36 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 07:14:36 INFO - Using env: {'DISPLAY': ':0', 07:14:36 INFO - 'HOME': '/home/cltbld', 07:14:36 INFO - 'LANG': 'en_US.UTF-8', 07:14:36 INFO - 'LANGUAGE': 'en_US:en', 07:14:36 INFO - 'LOGNAME': 'cltbld', 07:14:36 INFO - 'MAIL': '/var/mail/cltbld', 07:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:36 INFO - 'MOZ_NO_REMOTE': '1', 07:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:36 INFO - 'NO_EM_RESTART': '1', 07:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:36 INFO - 'PWD': '/builds/slave/test', 07:14:36 INFO - 'SHELL': '/bin/bash', 07:14:36 INFO - 'SHLVL': '1', 07:14:36 INFO - 'TERM': 'linux', 07:14:36 INFO - 'TMOUT': '86400', 07:14:36 INFO - 'USER': 'cltbld', 07:14:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', 07:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:36 INFO - '_': '/tools/buildbot/bin/python'} 07:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:36 INFO - Running setup.py (path:/tmp/pip-ie8En2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:37 INFO - Running setup.py (path:/tmp/pip-rzy3df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:37 INFO - Running setup.py (path:/tmp/pip-ZvFcD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:37 INFO - Running setup.py (path:/tmp/pip-UCp0RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:37 INFO - Running setup.py (path:/tmp/pip-jrDjBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:37 INFO - Running setup.py (path:/tmp/pip-PjbL35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:37 INFO - Running setup.py (path:/tmp/pip-1rBc2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:37 INFO - Running setup.py (path:/tmp/pip-i8Jqsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:37 INFO - Running setup.py (path:/tmp/pip-EoB1ZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:37 INFO - Running setup.py (path:/tmp/pip-Kj3_NH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:37 INFO - Running setup.py (path:/tmp/pip-4q42Sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:37 INFO - Running setup.py (path:/tmp/pip-ksm9GQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:37 INFO - Running setup.py (path:/tmp/pip-QhWY1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:37 INFO - Running setup.py (path:/tmp/pip-9Gg87V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:37 INFO - Running setup.py (path:/tmp/pip-I75hPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:38 INFO - Running setup.py (path:/tmp/pip-Q8i16e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:38 INFO - Running setup.py (path:/tmp/pip-cnV1uN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:14:38 INFO - Running setup.py install for manifestparser 07:14:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:14:38 INFO - Running setup.py install for mozcrash 07:14:38 INFO - Running setup.py install for mozdebug 07:14:38 INFO - Running setup.py install for mozdevice 07:14:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:14:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:14:38 INFO - Running setup.py install for mozfile 07:14:38 INFO - Running setup.py install for mozhttpd 07:14:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:14:38 INFO - Running setup.py install for mozinfo 07:14:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:14:38 INFO - Running setup.py install for mozInstall 07:14:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:14:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:14:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:14:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:14:38 INFO - Running setup.py install for mozleak 07:14:39 INFO - Running setup.py install for mozlog 07:14:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:14:39 INFO - Running setup.py install for moznetwork 07:14:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:14:39 INFO - Running setup.py install for mozprocess 07:14:39 INFO - Running setup.py install for mozprofile 07:14:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:14:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:14:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:14:39 INFO - Running setup.py install for mozrunner 07:14:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:14:39 INFO - Running setup.py install for mozscreenshot 07:14:39 INFO - Running setup.py install for moztest 07:14:39 INFO - Running setup.py install for mozversion 07:14:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:14:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:14:39 INFO - Cleaning up... 07:14:39 INFO - Return code: 0 07:14:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:39 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 0x7f714ba38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc710>, '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 0x12dd610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ddaa0>, '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': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', '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 07:14:39 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 07:14:39 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 07:14:39 INFO - Using env: {'DISPLAY': ':0', 07:14:39 INFO - 'HOME': '/home/cltbld', 07:14:39 INFO - 'LANG': 'en_US.UTF-8', 07:14:39 INFO - 'LANGUAGE': 'en_US:en', 07:14:39 INFO - 'LOGNAME': 'cltbld', 07:14:39 INFO - 'MAIL': '/var/mail/cltbld', 07:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:39 INFO - 'MOZ_NO_REMOTE': '1', 07:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:39 INFO - 'NO_EM_RESTART': '1', 07:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:39 INFO - 'PWD': '/builds/slave/test', 07:14:39 INFO - 'SHELL': '/bin/bash', 07:14:39 INFO - 'SHLVL': '1', 07:14:39 INFO - 'TERM': 'linux', 07:14:39 INFO - 'TMOUT': '86400', 07:14:39 INFO - 'USER': 'cltbld', 07:14:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', 07:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:39 INFO - '_': '/tools/buildbot/bin/python'} 07:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:40 INFO - Running setup.py (path:/tmp/pip-VzhTL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:40 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)) 07:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:40 INFO - Running setup.py (path:/tmp/pip-mJloTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:40 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)) 07:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:40 INFO - Running setup.py (path:/tmp/pip-QVgpxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:40 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)) 07:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:40 INFO - Running setup.py (path:/tmp/pip-MxTgTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:40 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)) 07:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:40 INFO - Running setup.py (path:/tmp/pip-tjKjAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:40 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)) 07:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:40 INFO - Running setup.py (path:/tmp/pip-ruajkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:40 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)) 07:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:40 INFO - Running setup.py (path:/tmp/pip-4B8nkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:40 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)) 07:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:40 INFO - Running setup.py (path:/tmp/pip-65FPoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:40 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)) 07:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:40 INFO - Running setup.py (path:/tmp/pip-klT6kT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:40 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)) 07:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:40 INFO - Running setup.py (path:/tmp/pip-5E1E6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:40 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)) 07:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:40 INFO - Running setup.py (path:/tmp/pip-82Ipv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:41 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)) 07:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:41 INFO - Running setup.py (path:/tmp/pip-rptQtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:41 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)) 07:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:41 INFO - Running setup.py (path:/tmp/pip-M88J6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:41 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)) 07:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:41 INFO - Running setup.py (path:/tmp/pip-_2PtHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:41 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)) 07:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:41 INFO - Running setup.py (path:/tmp/pip-D9jyfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:41 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)) 07:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:41 INFO - Running setup.py (path:/tmp/pip-XgV7XN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:41 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)) 07:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:41 INFO - Running setup.py (path:/tmp/pip-rfMa2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:41 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)) 07:14:41 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)) 07:14:41 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)) 07:14:41 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)) 07:14:41 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)) 07:14:41 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)) 07:14:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:14:41 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 07:14:41 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 07:14:41 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 07:14:41 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 07:14:41 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 07:14:41 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 07:14:43 INFO - Downloading blessings-1.6.tar.gz 07:14:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:14:43 INFO - Installing collected packages: blessings 07:14:43 INFO - Running setup.py install for blessings 07:14:43 INFO - Successfully installed blessings 07:14:43 INFO - Cleaning up... 07:14:43 INFO - Return code: 0 07:14:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:14:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:43 INFO - Reading from file tmpfile_stdout 07:14:43 INFO - Current package versions: 07:14:43 INFO - argparse == 1.2.1 07:14:43 INFO - blessings == 1.6 07:14:43 INFO - blobuploader == 1.2.4 07:14:43 INFO - docopt == 0.6.1 07:14:43 INFO - functools32 == 3.2.3-2 07:14:43 INFO - jsonschema == 2.5.1 07:14:43 INFO - manifestparser == 1.1 07:14:43 INFO - mozInstall == 1.12 07:14:43 INFO - mozcrash == 0.17 07:14:43 INFO - mozdebug == 0.1 07:14:43 INFO - mozdevice == 0.48 07:14:43 INFO - mozfile == 1.2 07:14:43 INFO - mozhttpd == 0.7 07:14:43 INFO - mozinfo == 0.9 07:14:43 INFO - mozleak == 0.1 07:14:43 INFO - mozlog == 3.2 07:14:43 INFO - moznetwork == 0.27 07:14:43 INFO - mozprocess == 0.22 07:14:43 INFO - mozprofile == 0.28 07:14:43 INFO - mozrunner == 6.11 07:14:43 INFO - mozscreenshot == 0.1 07:14:43 INFO - mozsystemmonitor == 0.3 07:14:43 INFO - moztest == 0.7 07:14:43 INFO - mozversion == 1.4 07:14:43 INFO - psutil == 3.1.1 07:14:43 INFO - requests == 1.2.3 07:14:43 INFO - wsgiref == 0.1.2 07:14:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:43 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 0x7f714ba38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc710>, '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 0x12dd610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ddaa0>, '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': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', '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 07:14:43 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 07:14:43 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 07:14:43 INFO - Using env: {'DISPLAY': ':0', 07:14:43 INFO - 'HOME': '/home/cltbld', 07:14:43 INFO - 'LANG': 'en_US.UTF-8', 07:14:43 INFO - 'LANGUAGE': 'en_US:en', 07:14:43 INFO - 'LOGNAME': 'cltbld', 07:14:43 INFO - 'MAIL': '/var/mail/cltbld', 07:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:43 INFO - 'MOZ_NO_REMOTE': '1', 07:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:43 INFO - 'NO_EM_RESTART': '1', 07:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:43 INFO - 'PWD': '/builds/slave/test', 07:14:43 INFO - 'SHELL': '/bin/bash', 07:14:43 INFO - 'SHLVL': '1', 07:14:43 INFO - 'TERM': 'linux', 07:14:43 INFO - 'TMOUT': '86400', 07:14:43 INFO - 'USER': 'cltbld', 07:14:43 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', 07:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:43 INFO - '_': '/tools/buildbot/bin/python'} 07:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:44 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)) 07:14:44 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)) 07:14:44 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)) 07:14:44 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)) 07:14:44 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)) 07:14:44 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)) 07:14:44 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)) 07:14:44 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)) 07:14:44 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)) 07:14:44 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)) 07:14:44 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)) 07:14:44 INFO - Cleaning up... 07:14:44 INFO - Return code: 0 07:14:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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')]} 07:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:44 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 0x7f714ba38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc710>, '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 0x12dd610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ddaa0>, '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': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', '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 07:14:44 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 07:14:44 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 07:14:44 INFO - Using env: {'DISPLAY': ':0', 07:14:44 INFO - 'HOME': '/home/cltbld', 07:14:44 INFO - 'LANG': 'en_US.UTF-8', 07:14:44 INFO - 'LANGUAGE': 'en_US:en', 07:14:44 INFO - 'LOGNAME': 'cltbld', 07:14:44 INFO - 'MAIL': '/var/mail/cltbld', 07:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:44 INFO - 'MOZ_NO_REMOTE': '1', 07:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:44 INFO - 'NO_EM_RESTART': '1', 07:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:44 INFO - 'PWD': '/builds/slave/test', 07:14:44 INFO - 'SHELL': '/bin/bash', 07:14:44 INFO - 'SHLVL': '1', 07:14:44 INFO - 'TERM': 'linux', 07:14:44 INFO - 'TMOUT': '86400', 07:14:44 INFO - 'USER': 'cltbld', 07:14:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', 07:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:44 INFO - '_': '/tools/buildbot/bin/python'} 07:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:14:44 INFO - Cleaning up... 07:14:44 INFO - Return code: 0 07:14:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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')]} 07:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:44 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 0x7f714ba38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12dc710>, '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 0x12dd610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ddaa0>, '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': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', '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 07:14:44 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 07:14:44 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 07:14:44 INFO - Using env: {'DISPLAY': ':0', 07:14:44 INFO - 'HOME': '/home/cltbld', 07:14:44 INFO - 'LANG': 'en_US.UTF-8', 07:14:44 INFO - 'LANGUAGE': 'en_US:en', 07:14:44 INFO - 'LOGNAME': 'cltbld', 07:14:44 INFO - 'MAIL': '/var/mail/cltbld', 07:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:44 INFO - 'MOZ_NO_REMOTE': '1', 07:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:44 INFO - 'NO_EM_RESTART': '1', 07:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:44 INFO - 'PWD': '/builds/slave/test', 07:14:44 INFO - 'SHELL': '/bin/bash', 07:14:44 INFO - 'SHLVL': '1', 07:14:44 INFO - 'TERM': 'linux', 07:14:44 INFO - 'TMOUT': '86400', 07:14:44 INFO - 'USER': 'cltbld', 07:14:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', 07:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:44 INFO - '_': '/tools/buildbot/bin/python'} 07:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:44 INFO - Downloading/unpacking flake8 07:14:44 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 07:14:44 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 07:14:44 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 07:14:44 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 07:14:44 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 07:14:44 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 07:14:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:14:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:14:46 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 07:14:46 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 07:14:46 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 07:14:46 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 07:14:46 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 07:14:46 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 07:14:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:14:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:14:46 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 07:14:46 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 07:14:46 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 07:14:46 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 07:14:46 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 07:14:46 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 07:14:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:14:46 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 07:14:46 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 07:14:46 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 07:14:46 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 07:14:46 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 07:14:46 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 07:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:14:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:14:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:14:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:14:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:14:47 INFO - no previously-included directories found matching 'docs/_build' 07:14:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:14:47 INFO - Running setup.py install for pep8 07:14:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:14:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:14:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:14:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:14:47 INFO - no previously-included directories found matching 'docs/_build' 07:14:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:14:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:14:47 INFO - Cleaning up... 07:14:47 INFO - Return code: 0 07:14:47 INFO - Running post-action listener: _resource_record_post_action 07:14:47 INFO - Running post-action listener: _start_resource_monitoring 07:14:47 INFO - Starting resource monitoring. 07:14:47 INFO - ##### 07:14:47 INFO - ##### Finished create-virtualenv step (success) 07:14:47 INFO - ##### 07:14:47 INFO - ##### 07:14:47 INFO - ##### Running install step. 07:14:47 INFO - ##### 07:14:47 INFO - Running pre-action listener: _resource_record_pre_action 07:14:47 INFO - Running main action method: install 07:14:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:47 INFO - Reading from file tmpfile_stdout 07:14:47 INFO - Detecting whether we're running mozinstall >=1.0... 07:14:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:14:47 INFO - Reading from file tmpfile_stdout 07:14:47 INFO - Output received: 07:14:47 INFO - Usage: mozinstall [options] installer 07:14:47 INFO - Options: 07:14:47 INFO - -h, --help show this help message and exit 07:14:47 INFO - -d DEST, --destination=DEST 07:14:47 INFO - Directory to install application into. [default: 07:14:47 INFO - "/builds/slave/test"] 07:14:47 INFO - --app=APP Application being installed. [default: firefox] 07:14:47 INFO - mkdir: /builds/slave/test/build/application 07:14:47 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'] 07:14:47 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 07:15:03 INFO - Reading from file tmpfile_stdout 07:15:03 INFO - Output received: 07:15:03 INFO - /builds/slave/test/build/application/firefox/firefox 07:15:03 INFO - Running post-action listener: _resource_record_post_action 07:15:03 INFO - ##### 07:15:03 INFO - ##### Finished install step (success) 07:15:03 INFO - ##### 07:15:03 INFO - ##### 07:15:03 INFO - ##### Running run-tests step. 07:15:03 INFO - ##### 07:15:03 INFO - Running pre-action listener: _resource_record_pre_action 07:15:03 INFO - Running main action method: run_tests 07:15:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:15:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:15:03 INFO - Python 2.7.3 07:15:03 INFO - Return code: 0 07:15:03 INFO - grabbing minidump binary from tooltool 07:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:15:03 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 0x12dc710>, '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 0x12dd610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ddaa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:15:03 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 07:15:03 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 07:15:03 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 07:15:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:15:03 INFO - Return code: 0 07:15:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:15:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:15:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:15:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:15:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:15:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:15:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:15:04 INFO - Return code: 0 07:15:04 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/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 07:15:04 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/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 07:15:04 INFO - Using env: {'DISPLAY': ':0', 07:15:04 INFO - 'HOME': '/home/cltbld', 07:15:04 INFO - 'LANG': 'en_US.UTF-8', 07:15:04 INFO - 'LANGUAGE': 'en_US:en', 07:15:04 INFO - 'LOGNAME': 'cltbld', 07:15:04 INFO - 'MAIL': '/var/mail/cltbld', 07:15:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:15:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:04 INFO - 'MOZ_NO_REMOTE': '1', 07:15:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:04 INFO - 'NO_EM_RESTART': '1', 07:15:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:04 INFO - 'PWD': '/builds/slave/test', 07:15:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:15:04 INFO - 'SHELL': '/bin/bash', 07:15:04 INFO - 'SHLVL': '1', 07:15:04 INFO - 'TERM': 'linux', 07:15:04 INFO - 'TMOUT': '86400', 07:15:04 INFO - 'USER': 'cltbld', 07:15:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467123250.97943-534840665', 07:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:04 INFO - '_': '/tools/buildbot/bin/python'} 07:15:04 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/QPK3yCBNTNSF6qK4_QuP2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 07:15:05 INFO - mozversion application_buildid: 20160628063121 07:15:05 INFO - mozversion application_changeset: 6b8a1c9c02517bb47d61eadece83273863cb32d5 07:15:05 INFO - mozversion application_display_name: Nightly 07:15:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:15:05 INFO - mozversion application_name: Firefox 07:15:05 INFO - mozversion application_remotingname: firefox 07:15:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:15:05 INFO - mozversion application_vendor: Mozilla 07:15:05 INFO - mozversion application_version: 50.0a1 07:15:05 INFO - mozversion platform_buildid: 20160628063121 07:15:05 INFO - mozversion platform_changeset: 6b8a1c9c02517bb47d61eadece83273863cb32d5 07:15:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:15:05 INFO - mozversion platform_version: 50.0a1 07:15:05 INFO - using testdate: 1467123305 07:15:05 INFO - actual date: 1467123305 07:15:05 INFO - starting webserver on 'localhost:52107' 07:15:05 INFO - SUITE-START | Running 2 tests 07:15:05 INFO - TEST-START | dromaeo_css 07:15:05 INFO - operating with platform_type : linux_ 07:15:05 INFO - Initialising browser for dromaeo_css test... 07:15:05 INFO - TEST-INFO | started process 32496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpboGcWb/profile http://localhost:52107/getInfo.html) 07:15:10 INFO - PROCESS | 32496 | __metrics Screen width/height:1600/1200 07:15:10 INFO - PROCESS | 32496 | colorDepth:24 07:15:10 INFO - PROCESS | 32496 | Browser inner width/height: 1024/697 07:15:10 INFO - PROCESS | 32496 | __metrics 07:15:10 ERROR - PROCESS | 32496 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:15:11 INFO - TEST-INFO | 32496: exit 0 07:15:11 INFO - Browser initialized. 07:15:11 INFO - Running cycle 1/1 for dromaeo_css test... 07:15:11 INFO - TEST-INFO | started process 32616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpboGcWb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:15:23 INFO - PROCESS | 32616 | RSS: Main: 186421248 07:15:23 INFO - PROCESS | 32616 | 07:16:13 INFO - PROCESS | 32616 | 1467123373383 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] 07:18:25 INFO - PROCESS | 32616 | Cycle 1(1): loaded http://localhost:52107/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52107/tests/dromaeo/cssquery-ext.html) 07:18:26 INFO - PROCESS | 32616 | RSS: Main: 188964864 07:18:26 INFO - PROCESS | 32616 | 07:21:28 INFO - PROCESS | 32616 | Cycle 1(1): loaded http://localhost:52107/tests/dromaeo/cssquery-ext.html (next: http://localhost:52107/tests/dromaeo/cssquery-jquery.html) 07:21:29 INFO - PROCESS | 32616 | RSS: Main: 188071936 07:21:29 INFO - PROCESS | 32616 | 07:24:31 INFO - PROCESS | 32616 | Cycle 1(1): loaded http://localhost:52107/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52107/tests/dromaeo/cssquery-mootools.html) 07:24:31 INFO - PROCESS | 32616 | RSS: Main: 189202432 07:24:31 INFO - PROCESS | 32616 | 07:27:33 INFO - PROCESS | 32616 | Cycle 1(1): loaded http://localhost:52107/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52107/tests/dromaeo/cssquery-prototype.html) 07:27:34 INFO - PROCESS | 32616 | RSS: Main: 187445248 07:27:34 INFO - PROCESS | 32616 | 07:30:37 INFO - PROCESS | 32616 | Cycle 1(1): loaded http://localhost:52107/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52107/tests/dromaeo/cssquery-yui.html) 07:30:37 INFO - PROCESS | 32616 | RSS: Main: 189280256 07:30:37 INFO - PROCESS | 32616 | 07:33:40 INFO - PROCESS | 32616 | Cycle 1(1): loaded http://localhost:52107/tests/dromaeo/cssquery-yui.html (next: http://localhost:52107/tests/dromaeo/cssquery-dojo.html) 07:33:40 INFO - PROCESS | 32616 | RSS: Main: 189857792 07:33:40 INFO - PROCESS | 32616 | 07:33:40 INFO - PROCESS | 32616 | __start_tp_report 07:33:40 INFO - PROCESS | 32616 | _x_x_mozilla_page_load 07:33:40 INFO - PROCESS | 32616 | _x_x_mozilla_page_load_details 07:33:40 INFO - PROCESS | 32616 | |i|pagename|runs| 07:33:40 INFO - PROCESS | 32616 | |0;dojo.html;2660.50780605588;2693.717159698231;2714.5249581323264;2717.1305182341657;2724.237213580197;4946.455889852114;4985.900281994358;5020.899582008357;5023.623228257877;5060;4851.199552073904;4947.257911313305;4964.503549645034;4970.950290497094;4997.975010124945;4518.548145185471;4546.29532422475;4587.931181032287;4658.138244424792;4700.341952126705;4348.5216626171095;4667.15991121598;4711.505291944348;4712.0575884823;4748.715077095368;4503.076869241798;4503.954960450419;4529.977350113261;4557.567031132037;4560.452745670507;4528.27547592387;4546.272596384562;4549.931751023737;4558.817647294104;4565.885852853672;4519.751413672247;4523.977380113079;4546.47715512717;4558.202314594932;4564.064366804797;4952.059108769322;5014.924776128361;5016.097102521545;5023.14606516893;5053.292539044537;5334.093204155264;5336.813211537617;5367.382750983647;5374.677519348813;5430.6741595504;5211.947880521222;5359.356877174764;5382.703951282678;5415.0523658360025;5422.15956526739;5000.199968005102;5011.173156429221;5018.473060328686;5033.79864805411;5065.265536497187;5520.254765606672;5522.447755224445;5534.640248383842;5539.2522009529;5569.220309156722;5134.563562097189;5162.354705661793;5225.059489291964;5231.476852314738;5271.920921186185;5207.6875387476875;5310.415854256029;5345.518903298722;5350.2242174885205;5366.517013468807;5226.555742761908;5236.895262094737;5292.735363231823;5297.576193904479;5301.54936830366;5116.718580478035;5211.687298762086;5220.791168353223;5281;5289.074411977888;4465.486469056035;4478.57453541913;4488.192125417456;4496.820127194941;4535.206338890681;3875.534935807721;3894.6300101490315;3902.980485097613;3925.666318362914;3946.585608511065;4527.592516673515;4557.749323787158;4590.563896429834;4595.586397224199;4613.700109492872;5368.731563421813;5398.271233383522;5398.73006349681;5403.405625381205;5454.672719636835;4464.620507256919;4593.563611456906;4601.815927362935;4612.285095810154;4649.256119021008;4753.714777113384;4762.3570817939135;4797.112534181188;4812.807487700523;4823.2282834746975;4984.40187177541;5009.9248511271635;5026.874328141826;5036.043151801146;5074.619403544675;5167.974160129175;5300.655457395257;5386.43442438554;5389.487998640123;5400.83797486076;4973.278874563096;4998.525140111829;5007.37407824022;5022.824201152942;5068.315777370008;5265.236540701653;5299.8410047698635;5318.255444237887;5320.255164276927;5320.2817619620855;5176.534111929945;5278.97360513195;5303.337082864642;5386.48828361305;5402.648827826179;5076.670016448919;5105.183170692671;5110.4123025852505;5160.716160611202;5234.633575649668;5178.663386879841;5182.948170518246;5187.19598462239;5191.402988656353;5236.083685355124;4983.9501604984935;5027.84916452507;5098.566621837185;5101.668391554537;5105.310783044241;5121.206213036985;5138.640295179302;5165.380154381498;5239.318888544465;5258.737063146904;5046.798128074836;5070.949290507047;5084.720340381166;5094.617903657167;5155.355580552431 07:33:40 INFO - PROCESS | 32616 | |1;ext.html;545.7265227962639;583.1981026089127;591.4676790888203;600.0159738029632;616.1743264026204;34806.47790283148;38089.047773805636;38328.04179895504;38435;38621.80689096558;40159;40545;40800.59199408005;40838.18323633526;40909.181816363656;7630.38956883448;7771.650275737606;7778.649960751752;7782.9610851945945;7796.064472263308;7640.274173953466;7806.648700808477;7832.216778322179;7836.333911617519;7838.216178382145;7782.49413788102;7801.258880406353;7838.059432868064;7870.3310218631195;7879.606019699021;7813.687452501893;7817.335526480256;7839.216078392172;7862.449628526006;7870.173631768667;7736;7772.455928085036;7826.765197044041;7828.452008359417;7861.764147075597;38382.232355353015;38490.422643660364;38527.61472385268;38560.42159367612;38836.611633883585;2738.9589156162674;3020.7734419918374;3035.802672826281;3078.5536097265995;3181.0933883842995;28594.285142871388;28711.282217944718;28882.566761498594;28902.132936011953;29082.709172908213;3373.8650453981813;3398.8130652814084;3425.143714071482;3447;3451.8101504417245;222311;222625;223542;223786.99999999837;224447;32517.18707032343;32777.3444531108;32794.50808237879;32841;32850;33264;33578.66421335804;34079.14802129967;34153.146171345914;36171.4574281386;14113.364898579382;14218.573442796733;14226.715465690628;14259.144451332953;14356.49752258666;10718.732031699114;10773.946130269298;10809.67570972872;10820.296680715728;10828.566857325777;18372.35696750634;18736.718949215774;18773.62452750937;18841.717374239397;18866.434006979813;6875;6936.375726184668;6982.93017069833;7050.189228238818;7138.107736532934;925.8888933328044;948.6205517792938;958.6932181701789;970.427447805798;973.8344481438172;27788.861055694997;28340.574891376647;28375;28709.856450717612;28873.56689649657;971.4754032822339;972.8005758819424;981.5484876956538;1007.8236308646104;1053.8313869780952;15048.473303434328;15337.6165595861;15411.460598878986;15496.92251538735;15590.688186236212;362109;371191;371477;371715.9798814057;372903;51381.22928156081;51910.740446297525;51934.48065519372;51955.22067168995;52172.21741673878;1178.9469473873696;1198.1912209258714;1216.6046035038648;1220.9633710988508;1236.7217376090307;26551.33621659474;27913.44173116567;28222.71777282201;28327.43345133127;28517.287067823472;44317.11365772731;44646.55353446424;44838.55161448344;44849.55150448584;45065.77467112643;314529;315316;315512;315613;315632;25605.231843044738;25852.22443326703;26287.21138365852;26386.4722705541;26394.340141496617;41786;42695.516970717625;42881.57118428776;42976.57023429726;43602.78198608987;37306.81346593249;37321.066973325884;37508;37869.24261514809;38298.617013829506;36107.458388123676;36442.27115457623;36896.63103368932;37243.44134838034;37445;36149.638503614624;36446.453303201;36698.26603467862;36994.26011479701;37090;29998.85000574983;33558.49662255019;34535.65464345324;34621.48067778935;34705.65294347024;25685.743142568335;25863.870680646476;26227.475450491263;26447.735522645296;26662.46675066449 07:33:40 INFO - PROCESS | 32616 | |2;jquery.html;374.86879592142753;377.92252588219407;378.2963687541173;381.3897763578273;396.7678907838914;16144.83855161448;16496.58758531037;17385.391511297108;17391.13044347784;17474.30102795888;11380.601678941219;15605.375784968588;16543.83456165438;16547;17359.566010849736;3612.349777040132;4690.296455531672;4880.633952453581;4914.164592019348;4932.284818701286;5303.575713942894;5601.691906945116;5605.27131472908;5716.056850619642;5742.54059675225;5693.259876216107;5708.372079071299;5736.368999410082;5860;6300.621962682231;6013.218281623383;6136.23297087864;6158.199434073542;6169.105479705418;6189.442950134487;5136.255242989746;5397.676139431646;5407.621466497347;5407.864803379907;5451.836444906659;9939.90060099397;9956.751081222956;12661.556845510455;16043.759343609856;20943.37169884906;1983.4942089767162;2001.559656875485;2090.0908104974233;2152.6340522111277;2360.1031607988853;9117.863232051524;9678.854817177747;13611.183329000192;14451.421943122263;14829.18439485828;1772.140511851751;1789.3826629812693;1804.9097545122822;1808.6021075363399;1841.4751795738284;63511.682441587494;64158.67920660414;82033.17966820316;82309.34521796214;82771.93070173233;16563.91718041402;16919.23863426149;16981.235844387033;17145.22846471912;17580.208890599955;30085;30135.69864301373;30426.54360184599;30496.54255186174;30551.69448305533;8584.154406802567;8758.255548278468;8904.643814247487;8910.108989101038;9000.59497322622;7202.819929501804;7295.8540829184185;7316.707331706672;7435.702571897172;7452.366548843301;3449.6550344965303;8396.832063358699;8582.485050896967;8814.338924580554;8842.425242359226;1775.4762345107965;1799.6706093726502;1814.7640806695044;1842.8802127861645;1843.806400327973;842.8145807922248;897.3314880414133;917.0783362720423;918.3158546882615;943.8867335919733;17058.658826823394;17293.13534323279;17416.390426335016;17755.467335979683;17812.55468613269;851.5018714052225;858.3991206155716;873.6942070275353;878.0122362342365;900.243795212025;9736.513174341255;9741.464219467998;9809.509524523744;9824.361416507903;9946.254030947708;286237;287824;393722;395106;396829;82964.58517707493;84052;85503;87548;89332.5533372342;909.3452714045876;920.6869664314165;943.2029934705163;951.8381875081253;956.3401253135314;16018.119003454456;16215.837841621433;16275.837241627432;16320.510384688478;16400.83599163993;37620.62379376171;37652.81173594224;38289.23421531498;38879.6112038876;38940;51998.22002669887;53178.4682153189;53648.195277070095;53932.73033634807;55406.16890746562;7814.726484573012;8012.238837310446;8105.108438071689;8112.391570632109;8163.79590510242;8938.37431379797;11101.777964440827;11704.239224450383;11997.40012999364;12137.57518486884;10400;10437.165026797686;10443.843342350023;10760.569577217137;10798.838017429902;10708.625198118028;10721.678349649523;10841;10943.562257509611;11040.282381645167;10238.33450825694;10773.569057237935;10950.890491094988;11023.283486573348;11105.722356941142;7520.774376768706;7966.203379661987;7977.760667179994;8074.798130046795;8112;9906.504674766376;10064.44645544502;10226.488675566341;10304.793904121725;10602.575896964343 07:33:40 INFO - PROCESS | 32616 | |3;mootools.html;1352.6347886070757;1365.7473367427026;1461.802656641353;1665.7501374793771;1668.2993142879989;6790.626515541643;7608.429367797409;7695.384369250461;8044.999999999993;8126.106128325887;7788.221177882209;7969.601519924009;8042.155573664769;8052.597370131484;8072.838543229146;2191.2878314547756;2294.1855641247366;2302.2747834432103;2304.066852924568;2306.6885970394032;2260.3219034289727;2262.8189744820374;2294.8852557372147;2297.115610489965;2298.0233400804673;2243.932682019542;2282.7831356021234;2291.8510296830736;2292.2893902890073;2294.5755035318434;2180;2188.5513469738667;2195.8133558647532;2204.5039866030174;2229.0749339024205;2230.810381117607;2272.7386350569564;2278.031836469494;2279.954400911989;2285.5428914217223;8073.394495412867;8082.232187942136;8098.595070246464;8139.226773456512;8144.348452123816;4600.907981840378;4687.22660760974;4700.271457924027;4706.576408123286;4715.174844402216;2861.113054952971;2933.259344713958;2987.686292939232;3005.4289684959786;3029.469842777505;916.702071826659;921.0421161991521;921.3320342751518;929.4376901974343;942.0438255171007;10790.622328218475;10865.619703310345;10866;10927.071198948099;10980.615678451215;4227.767472788964;4278.08021275421;4374.5625437456;4380.5838445347645;4428.911421771547;9120;9169.541522923828;9212.124848139416;9247.72256832296;9277.304202184863;4691.695039822401;4705.011947490997;4724.456687480915;4737.549932756451;4747.192977193886;3772.1512659651357;4075;4078.0824314528995;4198.202341555095;4373.671974601854;3547.5388199533895;3585.2112535242204;3627.2020155565733;3670.1742108025483;3696.094456858087;1245.819356193365;1263.2988691276246;1267.5690265309654;1268.6447794617523;1274.343712987812;800.855845947735;859.1580251353708;874.6195404998846;878.468526541446;907.8547432410783;5372.946270537323;5422.701751403711;5489.835304940858;5491.643043202179;5729.255196824386;415.4785743891397;429.68418212613705;430.09035889094963;436.18651215482896;438.7893810970688;3632.8365223565;3679.5952445231005;3726.4037753959237;3739.0652336915773;3776.3202623527477;9585;10048;10093.09162175393;10118.848217276747;10120.645777397756;9908.306418550632;9913.504324783731;9922.454265015349;9975.900240997496;10028.498575071217;7083.15002199729;7362.926370736224;7378;7539.849203015909;7570.507916985378;5481.945180548143;5597.608167428241;5685.573581981451;5733.971330143323;5816.47651711348;8503;8997.910020899708;9303.209227215762;9334.346595738505;9404.341696081208;8807.251383632463;8931.240844528287;9026.729198124067;9113.908860911306;9161.312901532545;6334.271558770616;6647.734090636513;6801.557898736566;6803.25164231944;6924.549904256207;7627;7644.0827100748265;7689.192634773268;7692.19231980634;7694.730684426018;6697.3637504437;6914.827129321807;6926.411255043176;6999.370056694922;7015;6499.0901273820755;6541.280459149585;6553.377429144223;6584.506162037962;6841.486888483483;6063.120847477003;6104.603200791934;6122.785702500391;6147.231596050494;6149.41580549847;4601.746903920182;4619.076184762994;4674.906501869876;4732.858014259577;4752.881177970578;4478.261086920752;4539.546045395434;4627.490975992706;4650.674452788272;4723.197056500472 07:33:40 INFO - PROCESS | 32616 | |4;prototype.html;299.61499473176974;307.5402273600966;311.30112896547257;311.954766558849;314.04999875376984;4940.443760215529;5039.521245481683;5089.5570126339335;5195.948040519598;5228.320318358613;5086.974565127179;5105.846824595259;5110.770015349309;5111.591072714174;5114.488551144884;3976.9204615907665;3980.781057041876;4018.2164477926744;4025.81883815229;4030.2141082488924;3945.9802700986456;4034.1931613677234;4045.4336392905016;4057.756534607933;4063.5326937402133;3960.8217630206564;3977.5226972763307;3983.103801644636;3983.521977362706;3984;3986.242613903349;3998.4801975743258;3999.480067591224;4000.6799456043736;4023.7786921719294;3569.39320315547;3572.2498275362204;3575.767575107636;3576.1059735066233;3580.9283814323826;4893.951060489385;5000.774965126578;5008.724520151391;5026.748662566857;5113.31550935758;4542.318652202163;4571.474280457756;4609.884752881171;4627.699199552018;4630.768461576908;5399.298091248152;5407.486288802557;5432.859099589052;5437.592180586472;5439.3200849893765;3599.6220396858216;3794.1273507093524;3794.90512737181;3801.3347664158937;3889.0083028827753;5660.745266463019;5664.688442135681;5677.574181936371;5696.2626398948305;5700.543956483513;3859.8842034739005;3870.2646497165447;3888.863889763845;3892.260470510594;3901.1027463683513;3854.1520865409566;3861.2470568239487;3920.882373528799;3948.1116748731306;3955.595763503972;4412.823487060546;4428.645708343389;4440.755758433317;4443.533428989974;4461.843835465808;5286.471352864683;5320.680759154463;5332.733363331818;5357.812476563302;5398.514133727984;1277.3294020639053;1323.5499930023839;1358.7350466658906;1363.3319673359981;1367.924764137982;817.5171088380563;829.742779738271;840.5671079394117;852.9957350213209;865.312076898867;4235.4917409911;4256.2764330063965;4275.781402300329;4296.419983302277;4317.589828966243;4927.334809800631;4936.605071594264;4949.232868905326;4964.851054468371;4978.680649627851;4173.311403618369;4216.765114489325;4261.274183955503;4264.445622069111;4276.2089013532595;2464.642626819137;2625.369911221293;2648.9072882449022;2658.787297016234;2668.026170447811;4572.376806233806;4653;4681.250999840077;4701.694389864648;4721.504242054535;4941.925871111936;5020.297158397827;5027.271045698426;5054.772535235923;5055.646104772704;4782.856514304576;5212.270282160424;5216.947830521722;5221.7128057956415;5272.499112584452;5648.09630459141;5667.319921609268;5707.486326230659;5714.514226301275;5732.34078081026;5283.867903302448;5481.424450432647;5490.258815059916;5490.862728431821;5539.750711218086;5065.848024559269;5243.68537887728;5243.883551412123;5262.7632506360205;5291.867703307448;3874.1864208516527;3894.9415758764208;3946.2896678598127;3947.1513624569707;3961.168154687548;5293.179557168645;5329.733513324396;5690.691141037667;5693.430656934439;5695.629784064023;5318.547923426552;5475.206095116266;5484.232207491034;5503;5525.778968841201;5467.835964921059;5511.311086114236;5525.585581081355;5532.1701744737;5552.944470555404;5192.922106168335;5335.626506144533;5375.871067075958;5408.405075441777;5434.728263586726;5455;5475.780968761205;5485.314335708036;5486.396496385474;5504.559635229252;5353.759080841293;5362.812301569426;5366.6779993200535;5408.13469844823;5433.619646624698 07:33:40 INFO - PROCESS | 32616 | |5;yui.html;682.4847240333547;687.2955220898579;704.788563430971;714.7641278378136;725.285593690215;11396.715082122952;11876.821847672292;11929.701757456069;11938;11986.820197697041;12402;13294.534691285808;13314;13319.800202996963;13320.800187997187;616.4636766013574;773.4083426178978;774.5391492062214;775.1550809617515;797.5254723439544;787.7479206653873;787.9921200788004;790.9406794490436;791.1613689489132;795.1690483444785;826.7767702720262;827.2389401750374;828.0849661124461;828.714093637697;829.1004260377498;822.144969231998;822.3298012120104;822.3791037766478;822.3914303415489;823.086374124721;598.6946657204813;599.4515018757832;601.5879122800895;603.0863242188088;604.1843511259764;12704.301263430507;12773.361331933365;12803.935980320131;12850.614481565568;12891.548795792196;13391.263480508567;13635.113717608423;13806.240656763874;13819.309034548332;13974.93012534941;10709.46452677363;10811.729706757314;10813.08088812452;10895.291806032583;10898.237123401364;3368.326334733063;3374.493825926106;3436.1409647588102;3441.896743097711;3469.2020835208045;57778;58110.12834807481;58350.70824645892;58414.70792646052;58590.70704646492;10537.525811338508;10647.201459890539;10666.946665266623;10729.83905241422;10976;19806.108725107406;19911.502212444517;20082.39752807418;20093.39719808408;20181.192752290037;6950.721971121098;6981.476389270825;7046.718131274794;7100.857982840417;7411.59236242001;3848.3073046851837;3868.9613103869165;3898.083950271684;3905.2189562087697;3910.100676844285;2854.200823769348;2961.304093538017;2961.7038296170213;2962.259435141215;2966.317746918178;500.29958058718086;501.4884817486144;504.20335869326374;511.83365406242376;518.1502336168686;465.9580637742619;577.803546794092;601.3024891126272;606.3693758491208;636.9585976911486;7299.927000730031;7511.624418779039;7729.149793522708;7799.922000780033;7892.36861051126;457.1040760110155;502.3394236578887;571.1917636544243;571.7141429285357;583.547750493371;3460.5501284833313;3654.9817250914107;3710.109573702292;3717.1450566369886;3763.6800871925643;49809.75095124501;97795.51102244586;98850;99215;99692.00307996973;84656;85977.5701121503;85992.57003715067;86462;86908.13091869;46073;47793.52206477891;73916;74109.6294518524;76371;7037.859242815218;7082.220955694766;7084.539504932369;7115.395191408788;7171.748988785367;44931.32603011023;45810.31284530801;46147;47045.52954470411;47222.291665624354;64769;65995.67002164958;66715.3328466709;66866.66566667135;67098.66450667716;9370.531473426438;9495;9551.617935282511;9572;9688.75778105553;10656.520456579317;10836.67489975302;10975.94375090243;11120.332780033224;11181.664550063511;10045.196384289093;10308.896911030793;10379.27345085867;10490.842637360598;10632.149428045583;9566.712998610054;9734.172595329193;9814.06766357195;9915.20678345745;10036.749081273027;9857.307444850603;10013.347797613313;10017.649382271586;10038.155564976916;10040.347377420445;8613.48319100856;8653.610587523703;8682.392232543662;8746.65013399457;8750.912490875264;8151.83696326082;8685.6233843705;8851.513166775889;8920.643174273217;8952.373333866828 07:33:40 INFO - PROCESS | 32616 | __end_tp_report 07:33:40 INFO - PROCESS | 32616 | __start_cc_report 07:33:40 INFO - PROCESS | 32616 | _x_x_mozilla_cycle_collect,383 07:33:40 INFO - PROCESS | 32616 | __end_cc_report 07:33:40 INFO - PROCESS | 32616 | __startTimestamp1467124420376__endTimestamp 07:33:40 INFO - PROCESS | 32616 | 07:33:40 INFO - PROCESS | 32616 | ------- Summary: start ------- 07:33:40 INFO - PROCESS | 32616 | Number of tests: 6 07:33:40 INFO - PROCESS | 32616 | 07:33:40 INFO - PROCESS | 32616 | [#0] dojo.html Cycles:165 Average:4916.67 Median:5046.80 stddev:532.18 (10.5%) stddev-sans-first:503.52 07:33:40 INFO - PROCESS | 32616 | Values: 2660.5 2693.7 2714.5 2717.1 2724.2 4946.5 4985.9 5020.9 5023.6 5060.0 4851.2 4947.3 4964.5 4971.0 4998.0 4518.5 4546.3 4587.9 4658.1 4700.3 4348.5 4667.2 4711.5 4712.1 4748.7 4503.1 4504.0 4530.0 4557.6 4560.5 4528.3 4546.3 4549.9 4558.8 4565.9 4519.8 4524.0 4546.5 4558.2 4564.1 4952.1 5014.9 5016.1 5023.1 5053.3 5334.1 5336.8 5367.4 5374.7 5430.7 5211.9 5359.4 5382.7 5415.1 5422.2 5000.2 5011.2 5018.5 5033.8 5065.3 5520.3 5522.4 5534.6 5539.3 5569.2 5134.6 5162.4 5225.1 5231.5 5271.9 5207.7 5310.4 5345.5 5350.2 5366.5 5226.6 5236.9 5292.7 5297.6 5301.5 5116.7 5211.7 5220.8 5281.0 5289.1 4465.5 4478.6 4488.2 4496.8 4535.2 3875.5 3894.6 3903.0 3925.7 3946.6 4527.6 4557.7 4590.6 4595.6 4613.7 5368.7 5398.3 5398.7 5403.4 5454.7 4464.6 4593.6 4601.8 4612.3 4649.3 4753.7 4762.4 4797.1 4812.8 4823.2 4984.4 5009.9 5026.9 5036.0 5074.6 5168.0 5300.7 5386.4 5389.5 5400.8 4973.3 4998.5 5007.4 5022.8 5068.3 5265.2 5299.8 5318.3 5320.3 5320.3 5176.5 5279.0 5303.3 5386.5 5402.6 5076.7 5105.2 5110.4 5160.7 5234.6 5178.7 5182.9 5187.2 5191.4 5236.1 4984.0 5027.8 5098.6 5101.7 5105.3 5121.2 5138.6 5165.4 5239.3 5258.7 5046.8 5070.9 5084.7 5094.6 5155.4 07:33:40 INFO - PROCESS | 32616 | 07:33:40 INFO - PROCESS | 32616 | [#1] ext.html Cycles:180 Average:45256.25 Median:199275.64 stddev:81200.36 (40.7%) stddev-sans-first:81358.76 07:33:40 INFO - PROCESS | 32616 | Values: 545.7 583.2 591.5 600.0 616.2 34806.5 38089.0 38328.0 38435.0 38621.8 40159.0 40545.0 40800.6 40838.2 40909.2 7630.4 7771.7 7778.6 7783.0 7796.1 7640.3 7806.6 7832.2 7836.3 7838.2 7782.5 7801.3 7838.1 7870.3 7879.6 7813.7 7817.3 7839.2 7862.4 7870.2 7736.0 7772.5 7826.8 7828.5 7861.8 38382.2 38490.4 38527.6 38560.4 38836.6 2739.0 3020.8 3035.8 3078.6 3181.1 28594.3 28711.3 28882.6 28902.1 29082.7 3373.9 3398.8 3425.1 3447.0 3451.8 222311.0 222625.0 223542.0 223787.0 224447.0 32517.2 32777.3 32794.5 32841.0 32850.0 33264.0 33578.7 34079.1 34153.1 36171.5 14113.4 14218.6 14226.7 14259.1 14356.5 10718.7 10773.9 10809.7 10820.3 10828.6 18372.4 18736.7 18773.6 18841.7 18866.4 6875.0 6936.4 6982.9 7050.2 7138.1 925.9 948.6 958.7 970.4 973.8 27788.9 28340.6 28375.0 28709.9 28873.6 971.5 972.8 981.5 1007.8 1053.8 15048.5 15337.6 15411.5 15496.9 15590.7 362109.0 371191.0 371477.0 371716.0 372903.0 51381.2 51910.7 51934.5 51955.2 52172.2 1178.9 1198.2 1216.6 1221.0 1236.7 26551.3 27913.4 28222.7 28327.4 28517.3 44317.1 44646.6 44838.6 44849.6 45065.8 314529.0 315316.0 315512.0 315613.0 315632.0 25605.2 25852.2 26287.2 26386.5 26394.3 41786.0 42695.5 42881.6 42976.6 43602.8 37306.8 37321.1 37508.0 37869.2 38298.6 36107.5 36442.3 36896.6 37243.4 37445.0 36149.6 36446.5 36698.3 36994.3 37090.0 29998.9 33558.5 34535.7 34621.5 34705.7 25685.7 25863.9 26227.5 26447.7 26662.5 07:33:40 INFO - PROCESS | 32616 | 07:33:40 INFO - PROCESS | 32616 | [#2] jquery.html Cycles:180 Average:24557.88 Median:200759.65 stddev:59380.69 (29.6%) stddev-sans-first:59519.51 07:33:40 INFO - PROCESS | 32616 | Values: 374.9 377.9 378.3 381.4 396.8 16144.8 16496.6 17385.4 17391.1 17474.3 11380.6 15605.4 16543.8 16547.0 17359.6 3612.3 4690.3 4880.6 4914.2 4932.3 5303.6 5601.7 5605.3 5716.1 5742.5 5693.3 5708.4 5736.4 5860.0 6300.6 6013.2 6136.2 6158.2 6169.1 6189.4 5136.3 5397.7 5407.6 5407.9 5451.8 9939.9 9956.8 12661.6 16043.8 20943.4 1983.5 2001.6 2090.1 2152.6 2360.1 9117.9 9678.9 13611.2 14451.4 14829.2 1772.1 1789.4 1804.9 1808.6 1841.5 63511.7 64158.7 82033.2 82309.3 82771.9 16563.9 16919.2 16981.2 17145.2 17580.2 30085.0 30135.7 30426.5 30496.5 30551.7 8584.2 8758.3 8904.6 8910.1 9000.6 7202.8 7295.9 7316.7 7435.7 7452.4 3449.7 8396.8 8582.5 8814.3 8842.4 1775.5 1799.7 1814.8 1842.9 1843.8 842.8 897.3 917.1 918.3 943.9 17058.7 17293.1 17416.4 17755.5 17812.6 851.5 858.4 873.7 878.0 900.2 9736.5 9741.5 9809.5 9824.4 9946.3 286237.0 287824.0 393722.0 395106.0 396829.0 82964.6 84052.0 85503.0 87548.0 89332.6 909.3 920.7 943.2 951.8 956.3 16018.1 16215.8 16275.8 16320.5 16400.8 37620.6 37652.8 38289.2 38879.6 38940.0 51998.2 53178.5 53648.2 53932.7 55406.2 7814.7 8012.2 8105.1 8112.4 8163.8 8938.4 11101.8 11704.2 11997.4 12137.6 10400.0 10437.2 10443.8 10760.6 10798.8 10708.6 10721.7 10841.0 10943.6 11040.3 10238.3 10773.6 10950.9 11023.3 11105.7 7520.8 7966.2 7977.8 8074.8 8112.0 9906.5 10064.4 10226.5 10304.8 10602.6 07:33:40 INFO - PROCESS | 32616 | 07:33:40 INFO - PROCESS | 32616 | [#3] mootools.html Cycles:180 Average:5226.98 Median:4728.66 stddev:2945.57 (62.3%) stddev-sans-first:2939.45 07:33:40 INFO - PROCESS | 32616 | Values: 1352.6 1365.7 1461.8 1665.8 1668.3 6790.6 7608.4 7695.4 8045.0 8126.1 7788.2 7969.6 8042.2 8052.6 8072.8 2191.3 2294.2 2302.3 2304.1 2306.7 2260.3 2262.8 2294.9 2297.1 2298.0 2243.9 2282.8 2291.9 2292.3 2294.6 2180.0 2188.6 2195.8 2204.5 2229.1 2230.8 2272.7 2278.0 2280.0 2285.5 8073.4 8082.2 8098.6 8139.2 8144.3 4600.9 4687.2 4700.3 4706.6 4715.2 2861.1 2933.3 2987.7 3005.4 3029.5 916.7 921.0 921.3 929.4 942.0 10790.6 10865.6 10866.0 10927.1 10980.6 4227.8 4278.1 4374.6 4380.6 4428.9 9120.0 9169.5 9212.1 9247.7 9277.3 4691.7 4705.0 4724.5 4737.5 4747.2 3772.2 4075.0 4078.1 4198.2 4373.7 3547.5 3585.2 3627.2 3670.2 3696.1 1245.8 1263.3 1267.6 1268.6 1274.3 800.9 859.2 874.6 878.5 907.9 5372.9 5422.7 5489.8 5491.6 5729.3 415.5 429.7 430.1 436.2 438.8 3632.8 3679.6 3726.4 3739.1 3776.3 9585.0 10048.0 10093.1 10118.8 10120.6 9908.3 9913.5 9922.5 9975.9 10028.5 7083.2 7362.9 7378.0 7539.8 7570.5 5481.9 5597.6 5685.6 5734.0 5816.5 8503.0 8997.9 9303.2 9334.3 9404.3 8807.3 8931.2 9026.7 9113.9 9161.3 6334.3 6647.7 6801.6 6803.3 6924.5 7627.0 7644.1 7689.2 7692.2 7694.7 6697.4 6914.8 6926.4 6999.4 7015.0 6499.1 6541.3 6553.4 6584.5 6841.5 6063.1 6104.6 6122.8 6147.2 6149.4 4601.7 4619.1 4674.9 4732.9 4752.9 4478.3 4539.5 4627.5 4650.7 4723.2 07:33:40 INFO - PROCESS | 32616 | 07:33:40 INFO - PROCESS | 32616 | [#4] prototype.html Cycles:180 Average:4396.51 Median:4945.58 stddev:1305.88 (26.4%) stddev-sans-first:1272.83 07:33:40 INFO - PROCESS | 32616 | Values: 299.6 307.5 311.3 312.0 314.0 4940.4 5039.5 5089.6 5195.9 5228.3 5087.0 5105.8 5110.8 5111.6 5114.5 3976.9 3980.8 4018.2 4025.8 4030.2 3946.0 4034.2 4045.4 4057.8 4063.5 3960.8 3977.5 3983.1 3983.5 3984.0 3986.2 3998.5 3999.5 4000.7 4023.8 3569.4 3572.2 3575.8 3576.1 3580.9 4894.0 5000.8 5008.7 5026.7 5113.3 4542.3 4571.5 4609.9 4627.7 4630.8 5399.3 5407.5 5432.9 5437.6 5439.3 3599.6 3794.1 3794.9 3801.3 3889.0 5660.7 5664.7 5677.6 5696.3 5700.5 3859.9 3870.3 3888.9 3892.3 3901.1 3854.2 3861.2 3920.9 3948.1 3955.6 4412.8 4428.6 4440.8 4443.5 4461.8 5286.5 5320.7 5332.7 5357.8 5398.5 1277.3 1323.5 1358.7 1363.3 1367.9 817.5 829.7 840.6 853.0 865.3 4235.5 4256.3 4275.8 4296.4 4317.6 4927.3 4936.6 4949.2 4964.9 4978.7 4173.3 4216.8 4261.3 4264.4 4276.2 2464.6 2625.4 2648.9 2658.8 2668.0 4572.4 4653.0 4681.3 4701.7 4721.5 4941.9 5020.3 5027.3 5054.8 5055.6 4782.9 5212.3 5216.9 5221.7 5272.5 5648.1 5667.3 5707.5 5714.5 5732.3 5283.9 5481.4 5490.3 5490.9 5539.8 5065.8 5243.7 5243.9 5262.8 5291.9 3874.2 3894.9 3946.3 3947.2 3961.2 5293.2 5329.7 5690.7 5693.4 5695.6 5318.5 5475.2 5484.2 5503.0 5525.8 5467.8 5511.3 5525.6 5532.2 5552.9 5192.9 5335.6 5375.9 5408.4 5434.7 5455.0 5475.8 5485.3 5486.4 5504.6 5353.8 5362.8 5366.7 5408.1 5433.6 07:33:40 INFO - PROCESS | 32616 | 07:33:40 INFO - PROCESS | 32616 | [#5] yui.html Cycles:180 Average:17012.94 Median:29346.84 stddev:24584.51 (83.8%) stddev-sans-first:24622.90 07:33:40 INFO - PROCESS | 32616 | Values: 682.5 687.3 704.8 714.8 725.3 11396.7 11876.8 11929.7 11938.0 11986.8 12402.0 13294.5 13314.0 13319.8 13320.8 616.5 773.4 774.5 775.2 797.5 787.7 788.0 790.9 791.2 795.2 826.8 827.2 828.1 828.7 829.1 822.1 822.3 822.4 822.4 823.1 598.7 599.5 601.6 603.1 604.2 12704.3 12773.4 12803.9 12850.6 12891.5 13391.3 13635.1 13806.2 13819.3 13974.9 10709.5 10811.7 10813.1 10895.3 10898.2 3368.3 3374.5 3436.1 3441.9 3469.2 57778.0 58110.1 58350.7 58414.7 58590.7 10537.5 10647.2 10666.9 10729.8 10976.0 19806.1 19911.5 20082.4 20093.4 20181.2 6950.7 6981.5 7046.7 7100.9 7411.6 3848.3 3869.0 3898.1 3905.2 3910.1 2854.2 2961.3 2961.7 2962.3 2966.3 500.3 501.5 504.2 511.8 518.2 466.0 577.8 601.3 606.4 637.0 7299.9 7511.6 7729.1 7799.9 7892.4 457.1 502.3 571.2 571.7 583.5 3460.6 3655.0 3710.1 3717.1 3763.7 49809.8 97795.5 98850.0 99215.0 99692.0 84656.0 85977.6 85992.6 86462.0 86908.1 46073.0 47793.5 73916.0 74109.6 76371.0 7037.9 7082.2 7084.5 7115.4 7171.7 44931.3 45810.3 46147.0 47045.5 47222.3 64769.0 65995.7 66715.3 66866.7 67098.7 9370.5 9495.0 9551.6 9572.0 9688.8 10656.5 10836.7 10975.9 11120.3 11181.7 10045.2 10308.9 10379.3 10490.8 10632.1 9566.7 9734.2 9814.1 9915.2 10036.7 9857.3 10013.3 10017.6 10038.2 10040.3 8613.5 8653.6 8682.4 8746.7 8750.9 8151.8 8685.6 8851.5 8920.6 8952.4 07:33:40 INFO - PROCESS | 32616 | -------- Summary: end -------- 07:33:40 INFO - PROCESS | 32616 | 07:33:41 INFO - TEST-INFO | 32616: exit 0 07:33:41 INFO - TEST-OK | dromaeo_css | took 1116087ms 07:33:41 INFO - TEST-START | kraken 07:33:41 INFO - operating with platform_type : linux_ 07:33:41 INFO - Initialising browser for kraken test... 07:33:41 INFO - TEST-INFO | started process 394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3ONiFO/profile http://localhost:52107/getInfo.html) 07:33:46 INFO - PROCESS | 394 | __metrics Screen width/height:1600/1200 07:33:46 INFO - PROCESS | 394 | colorDepth:24 07:33:46 INFO - PROCESS | 394 | Browser inner width/height: 1024/697 07:33:46 INFO - PROCESS | 394 | __metrics 07:33:46 ERROR - PROCESS | 394 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:33:47 INFO - TEST-INFO | 394: exit 0 07:33:47 INFO - Browser initialized. 07:33:47 INFO - Running cycle 1/1 for kraken test... 07:33:47 INFO - TEST-INFO | started process 513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3ONiFO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:34:00 INFO - PROCESS | 513 | RSS: Main: 186875904 07:34:00 INFO - PROCESS | 513 | 07:34:02 INFO - PROCESS | 513 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52107/tests/kraken/driver.html?testName=audio-beat-detection) 07:34:03 INFO - PROCESS | 513 | RSS: Main: 191127552 07:34:03 INFO - PROCESS | 513 | 07:34:06 INFO - PROCESS | 513 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52107/tests/kraken/driver.html?testName=audio-dft) 07:34:07 INFO - PROCESS | 513 | RSS: Main: 190586880 07:34:07 INFO - PROCESS | 513 | 07:34:10 INFO - PROCESS | 513 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52107/tests/kraken/driver.html?testName=audio-fft) 07:34:10 INFO - PROCESS | 513 | RSS: Main: 186527744 07:34:10 INFO - PROCESS | 513 | 07:34:12 INFO - PROCESS | 513 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52107/tests/kraken/driver.html?testName=audio-oscillator) 07:34:13 INFO - PROCESS | 513 | RSS: Main: 186699776 07:34:13 INFO - PROCESS | 513 | 07:34:15 INFO - PROCESS | 513 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52107/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:34:16 INFO - PROCESS | 513 | RSS: Main: 186966016 07:34:16 INFO - PROCESS | 513 | 07:34:19 INFO - PROCESS | 513 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52107/tests/kraken/driver.html?testName=imaging-darkroom) 07:34:20 INFO - PROCESS | 513 | RSS: Main: 187207680 07:34:20 INFO - PROCESS | 513 | 07:34:23 INFO - PROCESS | 513 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52107/tests/kraken/driver.html?testName=imaging-desaturate) 07:34:24 INFO - PROCESS | 513 | RSS: Main: 184537088 07:34:24 INFO - PROCESS | 513 | 07:34:27 INFO - PROCESS | 513 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52107/tests/kraken/driver.html?testName=json-parse-financial) 07:34:28 INFO - PROCESS | 513 | RSS: Main: 185581568 07:34:28 INFO - PROCESS | 513 | 07:34:29 INFO - PROCESS | 513 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52107/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:34:30 INFO - PROCESS | 513 | RSS: Main: 186404864 07:34:30 INFO - PROCESS | 513 | 07:34:32 INFO - PROCESS | 513 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52107/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:34:32 INFO - PROCESS | 513 | RSS: Main: 186789888 07:34:32 INFO - PROCESS | 513 | 07:34:35 INFO - PROCESS | 513 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52107/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:34:35 INFO - PROCESS | 513 | RSS: Main: 187424768 07:34:35 INFO - PROCESS | 513 | 07:34:38 INFO - PROCESS | 513 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:34:39 INFO - PROCESS | 513 | RSS: Main: 187731968 07:34:39 INFO - PROCESS | 513 | 07:34:42 INFO - PROCESS | 513 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:34:42 INFO - PROCESS | 513 | RSS: Main: 187109376 07:34:42 INFO - PROCESS | 513 | 07:34:44 INFO - PROCESS | 513 | Cycle 1(1): loaded http://localhost:52107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52107/tests/kraken/driver.html?testName=ai-astar) 07:34:44 INFO - PROCESS | 513 | RSS: Main: 188174336 07:34:44 INFO - PROCESS | 513 | 07:34:44 INFO - PROCESS | 513 | __start_tp_report 07:34:44 INFO - PROCESS | 513 | _x_x_mozilla_page_load 07:34:44 INFO - PROCESS | 513 | _x_x_mozilla_page_load_details 07:34:44 INFO - PROCESS | 513 | |i|pagename|runs| 07:34:44 INFO - PROCESS | 513 | |0;ai-astar;105;114;109;116;114;114;115;116;114;112 07:34:44 INFO - PROCESS | 513 | |1;audio-beat-detection;155;135;162;184;136;156;168;134;209;139 07:34:44 INFO - PROCESS | 513 | |2;audio-dft;164;166;178;164;162;163;164;163;163;162 07:34:44 INFO - PROCESS | 513 | |3;audio-fft;77;77;75;151;78;79;77;76;161;78 07:34:44 INFO - PROCESS | 513 | |4;audio-oscillator;86;87;149;86;88;90;139;88;95;136 07:34:44 INFO - PROCESS | 513 | |5;imaging-gaussian-blur;121;119;118;118;119;119;120;118;118;118 07:34:44 INFO - PROCESS | 513 | |6;imaging-darkroom;150;149;146;148;148;148;147;149;147;147 07:34:44 INFO - PROCESS | 513 | |7;imaging-desaturate;96;95;95;95;94;95;101;95;96;96 07:34:44 INFO - PROCESS | 513 | |8;json-parse-financial;64;66;65;65;67;63;65;66;65;65 07:34:44 INFO - PROCESS | 513 | |9;json-stringify-tinderbox;69;65;66;65;66;65;66;65;65;65 07:34:44 INFO - PROCESS | 513 | |10;stanford-crypto-aes;83;83;84;84;83;84;89;84;106;90 07:34:44 INFO - PROCESS | 513 | |11;stanford-crypto-ccm;140;131;134;139;141;134;138;145;145;134 07:34:44 INFO - PROCESS | 513 | |12;stanford-crypto-pbkdf2;166;167;179;173;176;174;164;173;166;171 07:34:44 INFO - PROCESS | 513 | |13;stanford-crypto-sha256-iterative;67;68;67;67;70;68;67;64;71;69 07:34:44 INFO - PROCESS | 513 | __end_tp_report 07:34:44 INFO - PROCESS | 513 | __start_cc_report 07:34:44 INFO - PROCESS | 513 | _x_x_mozilla_cycle_collect,971 07:34:44 INFO - PROCESS | 513 | __end_cc_report 07:34:44 INFO - PROCESS | 513 | __startTimestamp1467124484881__endTimestamp 07:34:44 INFO - PROCESS | 513 | 07:34:44 INFO - PROCESS | 513 | ------- Summary: start ------- 07:34:44 INFO - PROCESS | 513 | Number of tests: 14 07:34:44 INFO - PROCESS | 513 | 07:34:44 INFO - PROCESS | 513 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.45 (3.0%) stddev-sans-first:2.17 07:34:44 INFO - PROCESS | 513 | Values: 105.0 114.0 109.0 116.0 114.0 114.0 115.0 116.0 114.0 112.0 07:34:44 INFO - PROCESS | 513 | 07:34:44 INFO - PROCESS | 513 | [#1] audio-beat-detection Cycles:10 Average:157.80 Median:159.00 stddev:24.39 (15.3%) stddev-sans-first:25.85 07:34:44 INFO - PROCESS | 513 | Values: 155.0 135.0 162.0 184.0 136.0 156.0 168.0 134.0 209.0 139.0 07:34:44 INFO - PROCESS | 513 | 07:34:44 INFO - PROCESS | 513 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:4.75 (2.9%) stddev-sans-first:5.02 07:34:44 INFO - PROCESS | 513 | Values: 164.0 166.0 178.0 164.0 162.0 163.0 164.0 163.0 163.0 162.0 07:34:44 INFO - PROCESS | 513 | 07:34:44 INFO - PROCESS | 513 | [#3] audio-fft Cycles:10 Average:92.90 Median:77.00 stddev:33.36 (43.3%) stddev-sans-first:34.88 07:34:44 INFO - PROCESS | 513 | Values: 77.0 77.0 75.0 151.0 78.0 79.0 77.0 76.0 161.0 78.0 07:34:44 INFO - PROCESS | 513 | 07:34:44 INFO - PROCESS | 513 | [#4] audio-oscillator Cycles:10 Average:104.40 Median:87.50 stddev:25.82 (29.5%) stddev-sans-first:26.51 07:34:44 INFO - PROCESS | 513 | Values: 86.0 87.0 149.0 86.0 88.0 90.0 139.0 88.0 95.0 136.0 07:34:44 INFO - PROCESS | 513 | 07:34:44 INFO - PROCESS | 513 | [#5] imaging-gaussian-blur Cycles:10 Average:118.80 Median:119.00 stddev:1.03 (0.9%) stddev-sans-first:0.73 07:34:44 INFO - PROCESS | 513 | Values: 121.0 119.0 118.0 118.0 119.0 119.0 120.0 118.0 118.0 118.0 07:34:44 INFO - PROCESS | 513 | 07:34:44 INFO - PROCESS | 513 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.20 (0.8%) stddev-sans-first:1.00 07:34:44 INFO - PROCESS | 513 | Values: 150.0 149.0 146.0 148.0 148.0 148.0 147.0 149.0 147.0 147.0 07:34:44 INFO - PROCESS | 513 | 07:34:44 INFO - PROCESS | 513 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:1.93 (2.0%) stddev-sans-first:2.05 07:34:44 INFO - PROCESS | 513 | Values: 96.0 95.0 95.0 95.0 94.0 95.0 101.0 95.0 96.0 96.0 07:34:44 INFO - PROCESS | 513 | 07:34:44 INFO - PROCESS | 513 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.00 stddev:1.10 (1.7%) stddev-sans-first:1.09 07:34:44 INFO - PROCESS | 513 | Values: 64.0 66.0 65.0 65.0 67.0 63.0 65.0 66.0 65.0 65.0 07:34:44 INFO - PROCESS | 513 | 07:34:44 INFO - PROCESS | 513 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:65.50 stddev:1.25 (1.9%) stddev-sans-first:0.50 07:34:44 INFO - PROCESS | 513 | Values: 69.0 65.0 66.0 65.0 66.0 65.0 66.0 65.0 65.0 65.0 07:34:44 INFO - PROCESS | 513 | 07:34:44 INFO - PROCESS | 513 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:84.00 stddev:7.13 (8.5%) stddev-sans-first:7.42 07:34:44 INFO - PROCESS | 513 | Values: 83.0 83.0 84.0 84.0 83.0 84.0 89.0 84.0 106.0 90.0 07:34:44 INFO - PROCESS | 513 | 07:34:44 INFO - PROCESS | 513 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:139.50 stddev:4.82 (3.5%) stddev-sans-first:5.06 07:34:44 INFO - PROCESS | 513 | Values: 140.0 131.0 134.0 139.0 141.0 134.0 138.0 145.0 145.0 134.0 07:34:44 INFO - PROCESS | 513 | 07:34:44 INFO - PROCESS | 513 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:173.00 stddev:4.95 (2.9%) stddev-sans-first:4.93 07:34:44 INFO - PROCESS | 513 | Values: 166.0 167.0 179.0 173.0 176.0 174.0 164.0 173.0 166.0 171.0 07:34:44 INFO - PROCESS | 513 | 07:34:44 INFO - PROCESS | 513 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.93 (2.8%) stddev-sans-first:2.03 07:34:44 INFO - PROCESS | 513 | Values: 67.0 68.0 67.0 67.0 70.0 68.0 67.0 64.0 71.0 69.0 07:34:44 INFO - PROCESS | 513 | -------- Summary: end -------- 07:34:44 INFO - PROCESS | 513 | 07:34:46 INFO - TEST-INFO | 513: exit 0 07:34:46 INFO - TEST-OK | kraken | took 64980ms 07:34:46 INFO - SUITE-END | took 1181s 07:34:46 INFO - Completed test suite (00:19:41) 07:34:46 INFO - javascript benchmark 07:34:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6529.201021686028, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2660.50780605588, 2693.717159698231, 2714.5249581323264, 2717.1305182341657, 2724.237213580197, 4946.455889852114, 4985.900281994358, 5020.899582008357, 5023.623228257877, 5060.0, 4851.199552073904, 4947.257911313305, 4964.503549645034, 4970.950290497094, 4997.975010124945, 4518.548145185471, 4546.29532422475, 4587.931181032287, 4658.138244424792, 4700.341952126705, 4348.5216626171095, 4667.15991121598, 4711.505291944348, 4712.0575884823, 4748.715077095368, 4503.076869241798, 4503.954960450419, 4529.977350113261, 4557.567031132037, 4560.452745670507, 4528.27547592387, 4546.272596384562, 4549.931751023737, 4558.817647294104, 4565.885852853672, 4519.751413672247, 4523.977380113079, 4546.47715512717, 4558.202314594932, 4564.064366804797, 4952.059108769322, 5014.924776128361, 5016.097102521545, 5023.14606516893, 5053.292539044537, 5334.093204155264, 5336.813211537617, 5367.382750983647, 5374.677519348813, 5430.6741595504, 5211.947880521222, 5359.356877174764, 5382.703951282678, 5415.0523658360025, 5422.15956526739, 5000.199968005102, 5011.173156429221, 5018.473060328686, 5033.79864805411, 5065.265536497187, 5520.254765606672, 5522.447755224445, 5534.640248383842, 5539.2522009529, 5569.220309156722, 5134.563562097189, 5162.354705661793, 5225.059489291964, 5231.476852314738, 5271.920921186185, 5207.6875387476875, 5310.415854256029, 5345.518903298722, 5350.2242174885205, 5366.517013468807, 5226.555742761908, 5236.895262094737, 5292.735363231823, 5297.576193904479, 5301.54936830366, 5116.718580478035, 5211.687298762086, 5220.791168353223, 5281.0, 5289.074411977888, 4465.486469056035, 4478.57453541913, 4488.192125417456, 4496.820127194941, 4535.206338890681, 3875.534935807721, 3894.6300101490315, 3902.980485097613, 3925.666318362914, 3946.585608511065, 4527.592516673515, 4557.749323787158, 4590.563896429834, 4595.586397224199, 4613.700109492872, 5368.731563421813, 5398.271233383522, 5398.73006349681, 5403.405625381205, 5454.672719636835, 4464.620507256919, 4593.563611456906, 4601.815927362935, 4612.285095810154, 4649.256119021008, 4753.714777113384, 4762.3570817939135, 4797.112534181188, 4812.807487700523, 4823.2282834746975, 4984.40187177541, 5009.9248511271635, 5026.874328141826, 5036.043151801146, 5074.619403544675, 5167.974160129175, 5300.655457395257, 5386.43442438554, 5389.487998640123, 5400.83797486076, 4973.278874563096, 4998.525140111829, 5007.37407824022, 5022.824201152942, 5068.315777370008, 5265.236540701653, 5299.8410047698635, 5318.255444237887, 5320.255164276927, 5320.2817619620855, 5176.534111929945, 5278.97360513195, 5303.337082864642, 5386.48828361305, 5402.648827826179, 5076.670016448919, 5105.183170692671, 5110.4123025852505, 5160.716160611202, 5234.633575649668, 5178.663386879841, 5182.948170518246, 5187.19598462239, 5191.402988656353, 5236.083685355124, 4983.9501604984935, 5027.84916452507, 5098.566621837185, 5101.668391554537, 5105.310783044241, 5121.206213036985, 5138.640295179302, 5165.380154381498, 5239.318888544465, 5258.737063146904, 5046.798128074836, 5070.949290507047, 5084.720340381166, 5094.617903657167, 5155.355580552431], "value": 4881.181497132863, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.7265227962639, 583.1981026089127, 591.4676790888203, 600.0159738029632, 616.1743264026204, 34806.47790283148, 38089.047773805636, 38328.04179895504, 38435.0, 38621.80689096558, 40159.0, 40545.0, 40800.59199408005, 40838.18323633526, 40909.181816363656, 7630.38956883448, 7771.650275737606, 7778.649960751752, 7782.9610851945945, 7796.064472263308, 7640.274173953466, 7806.648700808477, 7832.216778322179, 7836.333911617519, 7838.216178382145, 7782.49413788102, 7801.258880406353, 7838.059432868064, 7870.3310218631195, 7879.606019699021, 7813.687452501893, 7817.335526480256, 7839.216078392172, 7862.449628526006, 7870.173631768667, 7736.0, 7772.455928085036, 7826.765197044041, 7828.452008359417, 7861.764147075597, 38382.232355353015, 38490.422643660364, 38527.61472385268, 38560.42159367612, 38836.611633883585, 2738.9589156162674, 3020.7734419918374, 3035.802672826281, 3078.5536097265995, 3181.0933883842995, 28594.285142871388, 28711.282217944718, 28882.566761498594, 28902.132936011953, 29082.709172908213, 3373.8650453981813, 3398.8130652814084, 3425.143714071482, 3447.0, 3451.8101504417245, 222311.0, 222625.0, 223542.0, 223786.99999999837, 224447.0, 32517.18707032343, 32777.3444531108, 32794.50808237879, 32841.0, 32850.0, 33264.0, 33578.66421335804, 34079.14802129967, 34153.146171345914, 36171.4574281386, 14113.364898579382, 14218.573442796733, 14226.715465690628, 14259.144451332953, 14356.49752258666, 10718.732031699114, 10773.946130269298, 10809.67570972872, 10820.296680715728, 10828.566857325777, 18372.35696750634, 18736.718949215774, 18773.62452750937, 18841.717374239397, 18866.434006979813, 6875.0, 6936.375726184668, 6982.93017069833, 7050.189228238818, 7138.107736532934, 925.8888933328044, 948.6205517792938, 958.6932181701789, 970.427447805798, 973.8344481438172, 27788.861055694997, 28340.574891376647, 28375.0, 28709.856450717612, 28873.56689649657, 971.4754032822339, 972.8005758819424, 981.5484876956538, 1007.8236308646104, 1053.8313869780952, 15048.473303434328, 15337.6165595861, 15411.460598878986, 15496.92251538735, 15590.688186236212, 362109.0, 371191.0, 371477.0, 371715.9798814057, 372903.0, 51381.22928156081, 51910.740446297525, 51934.48065519372, 51955.22067168995, 52172.21741673878, 1178.9469473873696, 1198.1912209258714, 1216.6046035038648, 1220.9633710988508, 1236.7217376090307, 26551.33621659474, 27913.44173116567, 28222.71777282201, 28327.43345133127, 28517.287067823472, 44317.11365772731, 44646.55353446424, 44838.55161448344, 44849.55150448584, 45065.77467112643, 314529.0, 315316.0, 315512.0, 315613.0, 315632.0, 25605.231843044738, 25852.22443326703, 26287.21138365852, 26386.4722705541, 26394.340141496617, 41786.0, 42695.516970717625, 42881.57118428776, 42976.57023429726, 43602.78198608987, 37306.81346593249, 37321.066973325884, 37508.0, 37869.24261514809, 38298.617013829506, 36107.458388123676, 36442.27115457623, 36896.63103368932, 37243.44134838034, 37445.0, 36149.638503614624, 36446.453303201, 36698.26603467862, 36994.26011479701, 37090.0, 29998.85000574983, 33558.49662255019, 34535.65464345324, 34621.48067778935, 34705.65294347024, 25685.743142568335, 25863.870680646476, 26227.475450491263, 26447.735522645296, 26662.46675066449], "value": 17175.316016854293, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.86879592142753, 377.92252588219407, 378.2963687541173, 381.3897763578273, 396.7678907838914, 16144.83855161448, 16496.58758531037, 17385.391511297108, 17391.13044347784, 17474.30102795888, 11380.601678941219, 15605.375784968588, 16543.83456165438, 16547.0, 17359.566010849736, 3612.349777040132, 4690.296455531672, 4880.633952453581, 4914.164592019348, 4932.284818701286, 5303.575713942894, 5601.691906945116, 5605.27131472908, 5716.056850619642, 5742.54059675225, 5693.259876216107, 5708.372079071299, 5736.368999410082, 5860.0, 6300.621962682231, 6013.218281623383, 6136.23297087864, 6158.199434073542, 6169.105479705418, 6189.442950134487, 5136.255242989746, 5397.676139431646, 5407.621466497347, 5407.864803379907, 5451.836444906659, 9939.90060099397, 9956.751081222956, 12661.556845510455, 16043.759343609856, 20943.37169884906, 1983.4942089767162, 2001.559656875485, 2090.0908104974233, 2152.6340522111277, 2360.1031607988853, 9117.863232051524, 9678.854817177747, 13611.183329000192, 14451.421943122263, 14829.18439485828, 1772.140511851751, 1789.3826629812693, 1804.9097545122822, 1808.6021075363399, 1841.4751795738284, 63511.682441587494, 64158.67920660414, 82033.17966820316, 82309.34521796214, 82771.93070173233, 16563.91718041402, 16919.23863426149, 16981.235844387033, 17145.22846471912, 17580.208890599955, 30085.0, 30135.69864301373, 30426.54360184599, 30496.54255186174, 30551.69448305533, 8584.154406802567, 8758.255548278468, 8904.643814247487, 8910.108989101038, 9000.59497322622, 7202.819929501804, 7295.8540829184185, 7316.707331706672, 7435.702571897172, 7452.366548843301, 3449.6550344965303, 8396.832063358699, 8582.485050896967, 8814.338924580554, 8842.425242359226, 1775.4762345107965, 1799.6706093726502, 1814.7640806695044, 1842.8802127861645, 1843.806400327973, 842.8145807922248, 897.3314880414133, 917.0783362720423, 918.3158546882615, 943.8867335919733, 17058.658826823394, 17293.13534323279, 17416.390426335016, 17755.467335979683, 17812.55468613269, 851.5018714052225, 858.3991206155716, 873.6942070275353, 878.0122362342365, 900.243795212025, 9736.513174341255, 9741.464219467998, 9809.509524523744, 9824.361416507903, 9946.254030947708, 286237.0, 287824.0, 393722.0, 395106.0, 396829.0, 82964.58517707493, 84052.0, 85503.0, 87548.0, 89332.5533372342, 909.3452714045876, 920.6869664314165, 943.2029934705163, 951.8381875081253, 956.3401253135314, 16018.119003454456, 16215.837841621433, 16275.837241627432, 16320.510384688478, 16400.83599163993, 37620.62379376171, 37652.81173594224, 38289.23421531498, 38879.6112038876, 38940.0, 51998.22002669887, 53178.4682153189, 53648.195277070095, 53932.73033634807, 55406.16890746562, 7814.726484573012, 8012.238837310446, 8105.108438071689, 8112.391570632109, 8163.79590510242, 8938.37431379797, 11101.777964440827, 11704.239224450383, 11997.40012999364, 12137.57518486884, 10400.0, 10437.165026797686, 10443.843342350023, 10760.569577217137, 10798.838017429902, 10708.625198118028, 10721.678349649523, 10841.0, 10943.562257509611, 11040.282381645167, 10238.33450825694, 10773.569057237935, 10950.890491094988, 11023.283486573348, 11105.722356941142, 7520.774376768706, 7966.203379661987, 7977.760667179994, 8074.798130046795, 8112.0, 9906.504674766376, 10064.44645544502, 10226.488675566341, 10304.793904121725, 10602.575896964343], "value": 8866.511584020205, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.6347886070757, 1365.7473367427026, 1461.802656641353, 1665.7501374793771, 1668.2993142879989, 6790.626515541643, 7608.429367797409, 7695.384369250461, 8044.999999999993, 8126.106128325887, 7788.221177882209, 7969.601519924009, 8042.155573664769, 8052.597370131484, 8072.838543229146, 2191.2878314547756, 2294.1855641247366, 2302.2747834432103, 2304.066852924568, 2306.6885970394032, 2260.3219034289727, 2262.8189744820374, 2294.8852557372147, 2297.115610489965, 2298.0233400804673, 2243.932682019542, 2282.7831356021234, 2291.8510296830736, 2292.2893902890073, 2294.5755035318434, 2180.0, 2188.5513469738667, 2195.8133558647532, 2204.5039866030174, 2229.0749339024205, 2230.810381117607, 2272.7386350569564, 2278.031836469494, 2279.954400911989, 2285.5428914217223, 8073.394495412867, 8082.232187942136, 8098.595070246464, 8139.226773456512, 8144.348452123816, 4600.907981840378, 4687.22660760974, 4700.271457924027, 4706.576408123286, 4715.174844402216, 2861.113054952971, 2933.259344713958, 2987.686292939232, 3005.4289684959786, 3029.469842777505, 916.702071826659, 921.0421161991521, 921.3320342751518, 929.4376901974343, 942.0438255171007, 10790.622328218475, 10865.619703310345, 10866.0, 10927.071198948099, 10980.615678451215, 4227.767472788964, 4278.08021275421, 4374.5625437456, 4380.5838445347645, 4428.911421771547, 9120.0, 9169.541522923828, 9212.124848139416, 9247.72256832296, 9277.304202184863, 4691.695039822401, 4705.011947490997, 4724.456687480915, 4737.549932756451, 4747.192977193886, 3772.1512659651357, 4075.0, 4078.0824314528995, 4198.202341555095, 4373.671974601854, 3547.5388199533895, 3585.2112535242204, 3627.2020155565733, 3670.1742108025483, 3696.094456858087, 1245.819356193365, 1263.2988691276246, 1267.5690265309654, 1268.6447794617523, 1274.343712987812, 800.855845947735, 859.1580251353708, 874.6195404998846, 878.468526541446, 907.8547432410783, 5372.946270537323, 5422.701751403711, 5489.835304940858, 5491.643043202179, 5729.255196824386, 415.4785743891397, 429.68418212613705, 430.09035889094963, 436.18651215482896, 438.7893810970688, 3632.8365223565, 3679.5952445231005, 3726.4037753959237, 3739.0652336915773, 3776.3202623527477, 9585.0, 10048.0, 10093.09162175393, 10118.848217276747, 10120.645777397756, 9908.306418550632, 9913.504324783731, 9922.454265015349, 9975.900240997496, 10028.498575071217, 7083.15002199729, 7362.926370736224, 7378.0, 7539.849203015909, 7570.507916985378, 5481.945180548143, 5597.608167428241, 5685.573581981451, 5733.971330143323, 5816.47651711348, 8503.0, 8997.910020899708, 9303.209227215762, 9334.346595738505, 9404.341696081208, 8807.251383632463, 8931.240844528287, 9026.729198124067, 9113.908860911306, 9161.312901532545, 6334.271558770616, 6647.734090636513, 6801.557898736566, 6803.25164231944, 6924.549904256207, 7627.0, 7644.0827100748265, 7689.192634773268, 7692.19231980634, 7694.730684426018, 6697.3637504437, 6914.827129321807, 6926.411255043176, 6999.370056694922, 7015.0, 6499.0901273820755, 6541.280459149585, 6553.377429144223, 6584.506162037962, 6841.486888483483, 6063.120847477003, 6104.603200791934, 6122.785702500391, 6147.231596050494, 6149.41580549847, 4601.746903920182, 4619.076184762994, 4674.906501869876, 4732.858014259577, 4752.881177970578, 4478.261086920752, 4539.546045395434, 4627.490975992706, 4650.674452788272, 4723.197056500472], "value": 4148.572688169553, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.61499473176974, 307.5402273600966, 311.30112896547257, 311.954766558849, 314.04999875376984, 4940.443760215529, 5039.521245481683, 5089.5570126339335, 5195.948040519598, 5228.320318358613, 5086.974565127179, 5105.846824595259, 5110.770015349309, 5111.591072714174, 5114.488551144884, 3976.9204615907665, 3980.781057041876, 4018.2164477926744, 4025.81883815229, 4030.2141082488924, 3945.9802700986456, 4034.1931613677234, 4045.4336392905016, 4057.756534607933, 4063.5326937402133, 3960.8217630206564, 3977.5226972763307, 3983.103801644636, 3983.521977362706, 3984.0, 3986.242613903349, 3998.4801975743258, 3999.480067591224, 4000.6799456043736, 4023.7786921719294, 3569.39320315547, 3572.2498275362204, 3575.767575107636, 3576.1059735066233, 3580.9283814323826, 4893.951060489385, 5000.774965126578, 5008.724520151391, 5026.748662566857, 5113.31550935758, 4542.318652202163, 4571.474280457756, 4609.884752881171, 4627.699199552018, 4630.768461576908, 5399.298091248152, 5407.486288802557, 5432.859099589052, 5437.592180586472, 5439.3200849893765, 3599.6220396858216, 3794.1273507093524, 3794.90512737181, 3801.3347664158937, 3889.0083028827753, 5660.745266463019, 5664.688442135681, 5677.574181936371, 5696.2626398948305, 5700.543956483513, 3859.8842034739005, 3870.2646497165447, 3888.863889763845, 3892.260470510594, 3901.1027463683513, 3854.1520865409566, 3861.2470568239487, 3920.882373528799, 3948.1116748731306, 3955.595763503972, 4412.823487060546, 4428.645708343389, 4440.755758433317, 4443.533428989974, 4461.843835465808, 5286.471352864683, 5320.680759154463, 5332.733363331818, 5357.812476563302, 5398.514133727984, 1277.3294020639053, 1323.5499930023839, 1358.7350466658906, 1363.3319673359981, 1367.924764137982, 817.5171088380563, 829.742779738271, 840.5671079394117, 852.9957350213209, 865.312076898867, 4235.4917409911, 4256.2764330063965, 4275.781402300329, 4296.419983302277, 4317.589828966243, 4927.334809800631, 4936.605071594264, 4949.232868905326, 4964.851054468371, 4978.680649627851, 4173.311403618369, 4216.765114489325, 4261.274183955503, 4264.445622069111, 4276.2089013532595, 2464.642626819137, 2625.369911221293, 2648.9072882449022, 2658.787297016234, 2668.026170447811, 4572.376806233806, 4653.0, 4681.250999840077, 4701.694389864648, 4721.504242054535, 4941.925871111936, 5020.297158397827, 5027.271045698426, 5054.772535235923, 5055.646104772704, 4782.856514304576, 5212.270282160424, 5216.947830521722, 5221.7128057956415, 5272.499112584452, 5648.09630459141, 5667.319921609268, 5707.486326230659, 5714.514226301275, 5732.34078081026, 5283.867903302448, 5481.424450432647, 5490.258815059916, 5490.862728431821, 5539.750711218086, 5065.848024559269, 5243.68537887728, 5243.883551412123, 5262.7632506360205, 5291.867703307448, 3874.1864208516527, 3894.9415758764208, 3946.2896678598127, 3947.1513624569707, 3961.168154687548, 5293.179557168645, 5329.733513324396, 5690.691141037667, 5693.430656934439, 5695.629784064023, 5318.547923426552, 5475.206095116266, 5484.232207491034, 5503.0, 5525.778968841201, 5467.835964921059, 5511.311086114236, 5525.585581081355, 5532.1701744737, 5552.944470555404, 5192.922106168335, 5335.626506144533, 5375.871067075958, 5408.405075441777, 5434.728263586726, 5455.0, 5475.780968761205, 5485.314335708036, 5486.396496385474, 5504.559635229252, 5353.759080841293, 5362.812301569426, 5366.6779993200535, 5408.13469844823, 5433.619646624698], "value": 3976.161157004067, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.4847240333547, 687.2955220898579, 704.788563430971, 714.7641278378136, 725.285593690215, 11396.715082122952, 11876.821847672292, 11929.701757456069, 11938.0, 11986.820197697041, 12402.0, 13294.534691285808, 13314.0, 13319.800202996963, 13320.800187997187, 616.4636766013574, 773.4083426178978, 774.5391492062214, 775.1550809617515, 797.5254723439544, 787.7479206653873, 787.9921200788004, 790.9406794490436, 791.1613689489132, 795.1690483444785, 826.7767702720262, 827.2389401750374, 828.0849661124461, 828.714093637697, 829.1004260377498, 822.144969231998, 822.3298012120104, 822.3791037766478, 822.3914303415489, 823.086374124721, 598.6946657204813, 599.4515018757832, 601.5879122800895, 603.0863242188088, 604.1843511259764, 12704.301263430507, 12773.361331933365, 12803.935980320131, 12850.614481565568, 12891.548795792196, 13391.263480508567, 13635.113717608423, 13806.240656763874, 13819.309034548332, 13974.93012534941, 10709.46452677363, 10811.729706757314, 10813.08088812452, 10895.291806032583, 10898.237123401364, 3368.326334733063, 3374.493825926106, 3436.1409647588102, 3441.896743097711, 3469.2020835208045, 57778.0, 58110.12834807481, 58350.70824645892, 58414.70792646052, 58590.70704646492, 10537.525811338508, 10647.201459890539, 10666.946665266623, 10729.83905241422, 10976.0, 19806.108725107406, 19911.502212444517, 20082.39752807418, 20093.39719808408, 20181.192752290037, 6950.721971121098, 6981.476389270825, 7046.718131274794, 7100.857982840417, 7411.59236242001, 3848.3073046851837, 3868.9613103869165, 3898.083950271684, 3905.2189562087697, 3910.100676844285, 2854.200823769348, 2961.304093538017, 2961.7038296170213, 2962.259435141215, 2966.317746918178, 500.29958058718086, 501.4884817486144, 504.20335869326374, 511.83365406242376, 518.1502336168686, 465.9580637742619, 577.803546794092, 601.3024891126272, 606.3693758491208, 636.9585976911486, 7299.927000730031, 7511.624418779039, 7729.149793522708, 7799.922000780033, 7892.36861051126, 457.1040760110155, 502.3394236578887, 571.1917636544243, 571.7141429285357, 583.547750493371, 3460.5501284833313, 3654.9817250914107, 3710.109573702292, 3717.1450566369886, 3763.6800871925643, 49809.75095124501, 97795.51102244586, 98850.0, 99215.0, 99692.00307996973, 84656.0, 85977.5701121503, 85992.57003715067, 86462.0, 86908.13091869, 46073.0, 47793.52206477891, 73916.0, 74109.6294518524, 76371.0, 7037.859242815218, 7082.220955694766, 7084.539504932369, 7115.395191408788, 7171.748988785367, 44931.32603011023, 45810.31284530801, 46147.0, 47045.52954470411, 47222.291665624354, 64769.0, 65995.67002164958, 66715.3328466709, 66866.66566667135, 67098.66450667716, 9370.531473426438, 9495.0, 9551.617935282511, 9572.0, 9688.75778105553, 10656.520456579317, 10836.67489975302, 10975.94375090243, 11120.332780033224, 11181.664550063511, 10045.196384289093, 10308.896911030793, 10379.27345085867, 10490.842637360598, 10632.149428045583, 9566.712998610054, 9734.172595329193, 9814.06766357195, 9915.20678345745, 10036.749081273027, 9857.307444850603, 10013.347797613313, 10017.649382271586, 10038.155564976916, 10040.347377420445, 8613.48319100856, 8653.610587523703, 8682.392232543662, 8746.65013399457, 8750.912490875264, 8151.83696326082, 8685.6233843705, 8851.513166775889, 8920.643174273217, 8952.373333866828], "value": 6317.835227590816, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1589.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 109.0, 116.0, 114.0, 114.0, 115.0, 116.0, 114.0, 112.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 135.0, 162.0, 184.0, 136.0, 156.0, 168.0, 134.0, 209.0, 139.0], "value": 157.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 178.0, 164.0, 162.0, 163.0, 164.0, 163.0, 163.0, 162.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 151.0, 78.0, 79.0, 77.0, 76.0, 161.0, 78.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 149.0, 86.0, 88.0, 90.0, 139.0, 88.0, 95.0, 136.0], "value": 104.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 118.0, 118.0, 119.0, 119.0, 120.0, 118.0, 118.0, 118.0], "value": 118.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 146.0, 148.0, 148.0, 148.0, 147.0, 149.0, 147.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 101.0, 95.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 67.0, 63.0, 65.0, 66.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 84.0, 83.0, 84.0, 89.0, 84.0, 106.0, 90.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 131.0, 134.0, 139.0, 141.0, 134.0, 138.0, 145.0, 145.0, 134.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 179.0, 173.0, 176.0, 174.0, 164.0, 173.0, 166.0, 171.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 70.0, 68.0, 67.0, 64.0, 71.0, 69.0], "value": 67.8, "unit": "score"}]}]} 07:34:46 INFO - Return code: 0 07:34:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:34:46 ERROR - # TBPL SUCCESS # 07:34:46 INFO - Running post-action listener: _resource_record_post_action 07:34:46 INFO - ##### 07:34:46 INFO - ##### Finished run-tests step (success) 07:34:46 INFO - ##### 07:34:46 INFO - Running post-run listener: _resource_record_post_run 07:34:46 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 554930176; Read time: 132; Write time: 505964 07:34:46 INFO - TinderboxPrint: CPU usage
13.5% 07:34:46 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 132 07:34:46 INFO - TinderboxPrint: I/O write bytes / time
554,930,176 / 505,964 07:34:46 INFO - TinderboxPrint: CPU idle
8,271.7 (86.5%) 07:34:46 INFO - TinderboxPrint: CPU user
1,233.8 (12.9%) 07:34:46 INFO - TinderboxPrint: Swap in / out
0 / 0 07:34:46 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254808064; Read time: 0; Write time: 310716 07:34:46 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 299536384; Read time: 132; Write time: 195244 07:34:47 INFO - Running post-run listener: _upload_blobber_files 07:34:47 INFO - Blob upload gear active. 07:34:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:34:47 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 07:34:47 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'] 07:34:47 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 07:34:47 INFO - (blobuploader) - INFO - Open directory for files ... 07:34:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:34:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:34:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:48 INFO - (blobuploader) - INFO - Done attempting. 07:34:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:34:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:34:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:49 INFO - (blobuploader) - INFO - Done attempting. 07:34:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:34:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:34:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:53 INFO - (blobuploader) - INFO - Done attempting. 07:34:53 INFO - (blobuploader) - INFO - Iteration through files over. 07:34:53 INFO - Return code: 0 07:34:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:34:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:34:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad24cb3ea62886ae9f0f73928d44172ff4c2041305dcf1bfac31d06416bb13bd25981f33a5363d0b17c394d38f4fb6cfec3e14fcbf42ed53bff4804f674f3f54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2d9f360c3b4edd299e6dd0b5f860533e1361d0f10a2af2b731c2b404be23b897972a93032497c0cdf4af193404d5ec9360dd567abb58e2024d6fa828c7f1312", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e3cf4c657f29b412685142cc8e1022ce8188c2b95113050c0eb3057b9bfc06a9b039d26902501b182a1ea9843ffe4c92e72b52a9c0bab96c0c5b2dd6b338e13"} 07:34:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:34:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:34:53 INFO - Contents: 07:34:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad24cb3ea62886ae9f0f73928d44172ff4c2041305dcf1bfac31d06416bb13bd25981f33a5363d0b17c394d38f4fb6cfec3e14fcbf42ed53bff4804f674f3f54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2d9f360c3b4edd299e6dd0b5f860533e1361d0f10a2af2b731c2b404be23b897972a93032497c0cdf4af193404d5ec9360dd567abb58e2024d6fa828c7f1312", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e3cf4c657f29b412685142cc8e1022ce8188c2b95113050c0eb3057b9bfc06a9b039d26902501b182a1ea9843ffe4c92e72b52a9c0bab96c0c5b2dd6b338e13"} 07:34:53 INFO - Running post-run listener: copy_logs_to_upload_dir 07:34:53 INFO - Copying logs to upload dir... 07:34:53 INFO - mkdir: /builds/slave/test/build/upload/logs 07:34:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.235576 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-28 07:34:52.751337) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 07:34:52.754414) ========= 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=00204705a9daa57ed339a427000001b9-1467123250.97943-534840665 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/ad24cb3ea62886ae9f0f73928d44172ff4c2041305dcf1bfac31d06416bb13bd25981f33a5363d0b17c394d38f4fb6cfec3e14fcbf42ed53bff4804f674f3f54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2d9f360c3b4edd299e6dd0b5f860533e1361d0f10a2af2b731c2b404be23b897972a93032497c0cdf4af193404d5ec9360dd567abb58e2024d6fa828c7f1312", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e3cf4c657f29b412685142cc8e1022ce8188c2b95113050c0eb3057b9bfc06a9b039d26902501b182a1ea9843ffe4c92e72b52a9c0bab96c0c5b2dd6b338e13"} build_url:https://queue.taskcluster.net/v1/task/QPK3yCBNTNSF6qK4_QuP2g/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/QPK3yCBNTNSF6qK4_QuP2g/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/ad24cb3ea62886ae9f0f73928d44172ff4c2041305dcf1bfac31d06416bb13bd25981f33a5363d0b17c394d38f4fb6cfec3e14fcbf42ed53bff4804f674f3f54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2d9f360c3b4edd299e6dd0b5f860533e1361d0f10a2af2b731c2b404be23b897972a93032497c0cdf4af193404d5ec9360dd567abb58e2024d6fa828c7f1312", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e3cf4c657f29b412685142cc8e1022ce8188c2b95113050c0eb3057b9bfc06a9b039d26902501b182a1ea9843ffe4c92e72b52a9c0bab96c0c5b2dd6b338e13"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 07:34:52.779177) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:34:52.779499) ========= 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=00204705a9daa57ed339a427000001b9-1467123250.97943-534840665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:34:52.863650) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 07:34:52.863941) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 07:34:52.864218) ========= ========= Total master_lag: 0.18 =========