builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1466181286.99 results: success (0) buildid: 20160617085624 builduid: 3115ebc9282a4ff68148ed3a82c38cc1 revision: 530e96008b7e987c75ddbab59cabdc11f9bbabb9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 09:34:46.993522) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 09:34:46.993897) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 09:34:46.994171) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 09:34:47.010082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:34:47.010354) ========= 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=c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 09:34:48-- 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% 225M=0s 2016-06-17 09:34:48 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083013 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:34:47.106842) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:34:47.107119) ========= 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=c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020126 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:34:47.155572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:34:47.155872) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 530e96008b7e987c75ddbab59cabdc11f9bbabb9 --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 530e96008b7e987c75ddbab59cabdc11f9bbabb9 --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=c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 09:34:48,278 truncating revision to first 12 chars 2016-06-17 09:34:48,278 Setting DEBUG logging. 2016-06-17 09:34:48,278 attempt 1/10 2016-06-17 09:34:48,278 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/530e96008b7e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 09:34:48,823 unpacking tar archive at: fx-team-530e96008b7e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.889355 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:34:48.058391) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 09:34:48.058695) ========= script_repo_revision: 530e96008b7e987c75ddbab59cabdc11f9bbabb9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 09:34:48.059110) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 09:34:48.059391) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 09:34:48.069255) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-17 09:34:48.069523) ========= /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=c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:34:49 INFO - MultiFileLogger online at 20160617 09:34:49 in /builds/slave/test 09:34:49 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 09:34:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:34:49 INFO - {'append_to_log': False, 09:34:49 INFO - 'base_work_dir': '/builds/slave/test', 09:34:49 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:34:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:34:49 INFO - 'branch': 'Fx-Team-Non-PGO', 09:34:49 INFO - 'buildbot_json_path': 'buildprops.json', 09:34:49 INFO - 'config_files': ('talos/linux_config.py',), 09:34:49 INFO - 'default_actions': ('clobber', 09:34:49 INFO - 'read-buildbot-config', 09:34:49 INFO - 'download-and-extract', 09:34:49 INFO - 'populate-webroot', 09:34:49 INFO - 'create-virtualenv', 09:34:49 INFO - 'install', 09:34:49 INFO - 'run-tests'), 09:34:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:34:49 INFO - 'download_minidump_stackwalk': True, 09:34:49 INFO - 'download_symbols': 'ondemand', 09:34:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:34:49 INFO - 'tooltool.py': '/tools/tooltool.py', 09:34:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:34:49 INFO - '/tools/misc-python/virtualenv.py')}, 09:34:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:34:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:34:49 INFO - 'installer_path': 'installer.exe', 09:34:49 INFO - 'log_level': 'info', 09:34:49 INFO - 'log_name': 'talos', 09:34:49 INFO - 'log_to_console': True, 09:34:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:34:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:34:49 INFO - 'opt_config_files': (), 09:34:49 INFO - 'pip_index': False, 09:34:49 INFO - 'sps_profile': False, 09:34:49 INFO - 'sps_profile_interval': 0, 09:34:49 INFO - 'suite': 'dromaeojs-e10s', 09:34:49 INFO - 'system_bits': '32', 09:34:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:34:49 INFO - 'title': 'talos-linux64-ix-004', 09:34:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:34:49 INFO - 'use_talos_json': True, 09:34:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:34:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:34:49 INFO - 'work_dir': 'build'} 09:34:49 INFO - ##### 09:34:49 INFO - ##### Running clobber step. 09:34:49 INFO - ##### 09:34:49 INFO - Running pre-action listener: _resource_record_pre_action 09:34:49 INFO - Running main action method: clobber 09:34:49 INFO - rmtree: /builds/slave/test/build 09:34:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:34:49 INFO - Running post-action listener: _resource_record_post_action 09:34:49 INFO - ##### 09:34:49 INFO - ##### Finished clobber step (success) 09:34:49 INFO - ##### 09:34:49 INFO - ##### 09:34:49 INFO - ##### Running read-buildbot-config step. 09:34:49 INFO - ##### 09:34:49 INFO - Running pre-action listener: _resource_record_pre_action 09:34:49 INFO - Running main action method: read_buildbot_config 09:34:49 INFO - Using buildbot properties: 09:34:49 INFO - { 09:34:49 INFO - "project": "", 09:34:49 INFO - "product": "firefox", 09:34:49 INFO - "script_repo_revision": "production", 09:34:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:34:49 INFO - "repository": "", 09:34:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:34:49 INFO - "buildid": "20160617085624", 09:34:49 INFO - "pgo_build": "False", 09:34:49 INFO - "basedir": "/builds/slave/test", 09:34:49 INFO - "buildnumber": 1417, 09:34:49 INFO - "slavename": "talos-linux64-ix-004", 09:34:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:34:49 INFO - "platform": "ubuntu64_hw", 09:34:49 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:34:49 INFO - "branch": "fx-team", 09:34:49 INFO - "repo_path": "integration/fx-team", 09:34:49 INFO - "revision": "530e96008b7e987c75ddbab59cabdc11f9bbabb9", 09:34:49 INFO - "stage_platform": "linux64", 09:34:49 INFO - "builduid": "3115ebc9282a4ff68148ed3a82c38cc1", 09:34:49 INFO - "slavebuilddir": "test" 09:34:49 INFO - } 09:34:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:34:49 INFO - Running post-action listener: _resource_record_post_action 09:34:49 INFO - ##### 09:34:49 INFO - ##### Finished read-buildbot-config step (success) 09:34:49 INFO - ##### 09:34:49 INFO - ##### 09:34:49 INFO - ##### Running download-and-extract step. 09:34:49 INFO - ##### 09:34:49 INFO - Running pre-action listener: _resource_record_pre_action 09:34:49 INFO - Running main action method: download_and_extract 09:34:49 INFO - mkdir: /builds/slave/test/build/tests 09:34:49 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')]} 09:34:49 INFO - https://queue.taskcluster.net/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:34:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:34:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:34:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/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 09:34:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/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 09:34:50 INFO - Downloaded 1361 bytes. 09:34:50 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:34:50 INFO - Using the following test package requirements: 09:34:50 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:34:50 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:34:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:34:50 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:34:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:34:50 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:34:50 INFO - u'jsshell-linux-x86_64.zip'], 09:34:50 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:34:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:34:50 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:34:50 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:34:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:34:50 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:34:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:34:50 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:34:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:34:50 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:34:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:34:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:34:50 INFO - https://queue.taskcluster.net/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:34:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:34:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:34:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/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 09:34:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/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 09:34:53 INFO - Downloaded 22654592 bytes. 09:34:53 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'] 09:34:53 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 09:34:54 INFO - Return code: 0 09:34:54 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 09:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:54 INFO - https://queue.taskcluster.net/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:34:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:34:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:34:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/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 09:34:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/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 09:34:56 INFO - Downloaded 22654592 bytes. 09:34:56 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'] 09:34:56 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 09:34:58 INFO - Return code: 0 09:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:58 INFO - https://queue.taskcluster.net/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:34:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:34:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:34:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/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 09:34:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/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 09:34:59 INFO - Downloaded 14405384 bytes. 09:34:59 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'] 09:34:59 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 09:34:59 INFO - Return code: 0 09:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:34:59 INFO - https://queue.taskcluster.net/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:34:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:34:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:34:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/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 09:34:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C5pWj35TQ4C7IrktpKaYlQ/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 09:35:01 INFO - Downloaded 55442788 bytes. 09:35:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:35:01 INFO - mkdir: /builds/slave/test/properties 09:35:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:35:01 INFO - Writing to file /builds/slave/test/properties/build_url 09:35:01 INFO - Contents: 09:35:01 INFO - build_url:https://queue.taskcluster.net/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:35:01 INFO - Running post-action listener: _resource_record_post_action 09:35:01 INFO - Running post-action listener: set_extra_try_arguments 09:35:01 INFO - ##### 09:35:01 INFO - ##### Finished download-and-extract step (success) 09:35:01 INFO - ##### 09:35:01 INFO - ##### 09:35:01 INFO - ##### Running populate-webroot step. 09:35:01 INFO - ##### 09:35:01 INFO - Running pre-action listener: _resource_record_pre_action 09:35:01 INFO - Running main action method: populate_webroot 09:35:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:35:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:35:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:35:01 INFO - '--tppagecycles', 09:35:01 INFO - '7'], 09:35:01 INFO - 'tests': ['tsvgm']}}, 09:35:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:35:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:35:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:35:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:35:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:35:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:35:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:01 INFO - 'talos_options': ['--disable-e10s'], 09:35:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:35:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:35:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:01 INFO - 'talos_options': ['--disable-e10s'], 09:35:01 INFO - 'tests': ['damp', 'tps']}, 09:35:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:01 INFO - 'tests': ['damp', 'tps']}, 09:35:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:35:01 INFO - 'tests': ['dromaeo_dom']}, 09:35:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:35:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:35:01 INFO - 'tests': ['basic_compositor_video']}, 09:35:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:35:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:35:01 INFO - 'tests': ['a11yr', 09:35:01 INFO - 'ts_paint', 09:35:01 INFO - 'tpaint', 09:35:01 INFO - 'sessionrestore', 09:35:01 INFO - 'sessionrestore_no_auto_restore', 09:35:01 INFO - 'tabpaint']}, 09:35:01 INFO - 'other-e10s': {'tests': ['a11yr', 09:35:01 INFO - 'ts_paint', 09:35:01 INFO - 'tpaint', 09:35:01 INFO - 'sessionrestore', 09:35:01 INFO - 'sessionrestore_no_auto_restore', 09:35:01 INFO - 'tabpaint']}, 09:35:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:35:01 INFO - 'ts_paint', 09:35:01 INFO - 'tpaint', 09:35:01 INFO - 'sessionrestore', 09:35:01 INFO - 'sessionrestore_no_auto_restore', 09:35:01 INFO - 'tabpaint']}, 09:35:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:35:01 INFO - 'ts_paint', 09:35:01 INFO - 'tpaint', 09:35:01 INFO - 'sessionrestore', 09:35:01 INFO - 'sessionrestore_no_auto_restore', 09:35:01 INFO - 'tabpaint']}, 09:35:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:35:01 INFO - 'tests': ['a11yr', 09:35:01 INFO - 'ts_paint', 09:35:01 INFO - 'tpaint', 09:35:01 INFO - 'sessionrestore', 09:35:01 INFO - 'sessionrestore_no_auto_restore', 09:35:01 INFO - 'tabpaint']}, 09:35:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:35:01 INFO - 'tests': ['a11yr', 09:35:01 INFO - 'ts_paint', 09:35:01 INFO - 'tpaint', 09:35:01 INFO - 'sessionrestore', 09:35:01 INFO - 'sessionrestore_no_auto_restore', 09:35:01 INFO - 'tabpaint']}, 09:35:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:35:01 INFO - 'tests': ['tsvgx', 09:35:01 INFO - 'tsvgr_opacity', 09:35:01 INFO - 'tart', 09:35:01 INFO - 'tscrollx', 09:35:01 INFO - 'cart']}, 09:35:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:35:01 INFO - 'tsvgr_opacity', 09:35:01 INFO - 'tart', 09:35:01 INFO - 'tscrollx', 09:35:01 INFO - 'cart']}, 09:35:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:01 INFO - 'talos_options': ['--disable-e10s'], 09:35:01 INFO - 'tests': ['tp5o']}, 09:35:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:01 INFO - 'tests': ['tp5o']}, 09:35:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:01 INFO - 'talos_options': ['--disable-e10s', 09:35:01 INFO - '--xperf_path', 09:35:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:35:01 INFO - 'tests': ['tp5n']}, 09:35:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:01 INFO - 'talos_options': ['--xperf_path', 09:35:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:35:01 INFO - 'tests': ['tp5n']}}, 09:35:01 INFO - 'talos.zip': {'path': '', 09:35:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:35:01 INFO - Running post-action listener: _resource_record_post_action 09:35:01 INFO - ##### 09:35:01 INFO - ##### Finished populate-webroot step (success) 09:35:01 INFO - ##### 09:35:01 INFO - ##### 09:35:01 INFO - ##### Running create-virtualenv step. 09:35:01 INFO - ##### 09:35:01 INFO - Running pre-action listener: _resource_record_pre_action 09:35:01 INFO - Running main action method: create_virtualenv 09:35:01 INFO - Creating virtualenv /builds/slave/test/build/venv 09:35:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:35:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:35:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:35:02 INFO - Using real prefix '/usr' 09:35:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:35:02 INFO - Installing distribute.............................................................................................................................................................................................done. 09:35:04 INFO - Installing pip.................done. 09:35:04 INFO - Return code: 0 09:35:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8089eabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f1c0>, '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 0x18300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1830550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:35:04 INFO - Using env: {'DISPLAY': ':0', 09:35:04 INFO - 'HOME': '/home/cltbld', 09:35:04 INFO - 'LANG': 'en_US.UTF-8', 09:35:04 INFO - 'LANGUAGE': 'en_US:en', 09:35:04 INFO - 'LOGNAME': 'cltbld', 09:35:04 INFO - 'MAIL': '/var/mail/cltbld', 09:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:04 INFO - 'MOZ_NO_REMOTE': '1', 09:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:04 INFO - 'NO_EM_RESTART': '1', 09:35:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:04 INFO - 'PWD': '/builds/slave/test', 09:35:04 INFO - 'SHELL': '/bin/bash', 09:35:04 INFO - 'SHLVL': '1', 09:35:04 INFO - 'TERM': 'linux', 09:35:04 INFO - 'TMOUT': '86400', 09:35:04 INFO - 'USER': 'cltbld', 09:35:04 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 09:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:04 INFO - '_': '/tools/buildbot/bin/python'} 09:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:35:04 INFO - Cleaning up... 09:35:04 INFO - Return code: 0 09:35:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8089eabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f1c0>, '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 0x18300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1830550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:35:04 INFO - Using env: {'DISPLAY': ':0', 09:35:04 INFO - 'HOME': '/home/cltbld', 09:35:04 INFO - 'LANG': 'en_US.UTF-8', 09:35:04 INFO - 'LANGUAGE': 'en_US:en', 09:35:04 INFO - 'LOGNAME': 'cltbld', 09:35:04 INFO - 'MAIL': '/var/mail/cltbld', 09:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:04 INFO - 'MOZ_NO_REMOTE': '1', 09:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:04 INFO - 'NO_EM_RESTART': '1', 09:35:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:04 INFO - 'PWD': '/builds/slave/test', 09:35:04 INFO - 'SHELL': '/bin/bash', 09:35:04 INFO - 'SHLVL': '1', 09:35:04 INFO - 'TERM': 'linux', 09:35:04 INFO - 'TMOUT': '86400', 09:35:04 INFO - 'USER': 'cltbld', 09:35:04 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 09:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:04 INFO - '_': '/tools/buildbot/bin/python'} 09:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:04 INFO - Downloading/unpacking psutil>=3.1.1 09:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:35:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:35:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:35:06 INFO - Installing collected packages: psutil 09:35:06 INFO - Running setup.py install for psutil 09:35:07 INFO - building 'psutil._psutil_linux' extension 09:35:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:35:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:35:07 INFO - building 'psutil._psutil_posix' extension 09:35:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:35:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:35:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:35:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:35:07 INFO - Successfully installed psutil 09:35:07 INFO - Cleaning up... 09:35:07 INFO - Return code: 0 09:35:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:07 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 0x7f8089eabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f1c0>, '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 0x18300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1830550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:35:07 INFO - Using env: {'DISPLAY': ':0', 09:35:07 INFO - 'HOME': '/home/cltbld', 09:35:07 INFO - 'LANG': 'en_US.UTF-8', 09:35:07 INFO - 'LANGUAGE': 'en_US:en', 09:35:07 INFO - 'LOGNAME': 'cltbld', 09:35:07 INFO - 'MAIL': '/var/mail/cltbld', 09:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:07 INFO - 'MOZ_NO_REMOTE': '1', 09:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:07 INFO - 'NO_EM_RESTART': '1', 09:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:07 INFO - 'PWD': '/builds/slave/test', 09:35:07 INFO - 'SHELL': '/bin/bash', 09:35:07 INFO - 'SHLVL': '1', 09:35:07 INFO - 'TERM': 'linux', 09:35:07 INFO - 'TMOUT': '86400', 09:35:07 INFO - 'USER': 'cltbld', 09:35:07 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 09:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:07 INFO - '_': '/tools/buildbot/bin/python'} 09:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:35:09 INFO - Installing collected packages: mozsystemmonitor 09:35:09 INFO - Running setup.py install for mozsystemmonitor 09:35:09 INFO - Successfully installed mozsystemmonitor 09:35:09 INFO - Cleaning up... 09:35:09 INFO - Return code: 0 09:35:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8089eabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f1c0>, '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 0x18300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1830550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:35:09 INFO - Using env: {'DISPLAY': ':0', 09:35:09 INFO - 'HOME': '/home/cltbld', 09:35:09 INFO - 'LANG': 'en_US.UTF-8', 09:35:09 INFO - 'LANGUAGE': 'en_US:en', 09:35:09 INFO - 'LOGNAME': 'cltbld', 09:35:09 INFO - 'MAIL': '/var/mail/cltbld', 09:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:09 INFO - 'MOZ_NO_REMOTE': '1', 09:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:09 INFO - 'NO_EM_RESTART': '1', 09:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:09 INFO - 'PWD': '/builds/slave/test', 09:35:09 INFO - 'SHELL': '/bin/bash', 09:35:09 INFO - 'SHLVL': '1', 09:35:09 INFO - 'TERM': 'linux', 09:35:09 INFO - 'TMOUT': '86400', 09:35:09 INFO - 'USER': 'cltbld', 09:35:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 09:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:09 INFO - '_': '/tools/buildbot/bin/python'} 09:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:10 INFO - Downloading/unpacking jsonschema==2.5.1 09:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:35:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:12 INFO - Downloading functools32-3.2.3-2.tar.gz 09:35:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:35:12 INFO - warning: no files found matching '*.txt' 09:35:12 INFO - no previously-included directories found matching 'build' 09:35:12 INFO - no previously-included directories found matching 'dist' 09:35:12 INFO - no previously-included directories found matching '.git*' 09:35:12 INFO - Installing collected packages: jsonschema, functools32 09:35:12 INFO - Running setup.py install for functools32 09:35:12 INFO - warning: no files found matching '*.txt' 09:35:12 INFO - no previously-included directories found matching 'build' 09:35:12 INFO - no previously-included directories found matching 'dist' 09:35:12 INFO - no previously-included directories found matching '.git*' 09:35:12 INFO - Successfully installed jsonschema functools32 09:35:12 INFO - Cleaning up... 09:35:12 INFO - Return code: 0 09:35:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:35:12 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')]} 09:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:12 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')]} 09:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:12 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 0x7f8089eabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f1c0>, '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 0x18300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1830550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:35:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:35:12 INFO - Using env: {'DISPLAY': ':0', 09:35:12 INFO - 'HOME': '/home/cltbld', 09:35:12 INFO - 'LANG': 'en_US.UTF-8', 09:35:12 INFO - 'LANGUAGE': 'en_US:en', 09:35:12 INFO - 'LOGNAME': 'cltbld', 09:35:12 INFO - 'MAIL': '/var/mail/cltbld', 09:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:12 INFO - 'MOZ_NO_REMOTE': '1', 09:35:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:12 INFO - 'NO_EM_RESTART': '1', 09:35:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:12 INFO - 'PWD': '/builds/slave/test', 09:35:12 INFO - 'SHELL': '/bin/bash', 09:35:12 INFO - 'SHLVL': '1', 09:35:12 INFO - 'TERM': 'linux', 09:35:12 INFO - 'TMOUT': '86400', 09:35:12 INFO - 'USER': 'cltbld', 09:35:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 09:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:12 INFO - '_': '/tools/buildbot/bin/python'} 09:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:12 INFO - Downloading/unpacking blobuploader==1.2.4 09:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:14 INFO - Downloading blobuploader-1.2.4.tar.gz 09:35:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:35:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:35:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:15 INFO - Downloading docopt-0.6.1.tar.gz 09:35:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:35:15 INFO - Installing collected packages: blobuploader, requests, docopt 09:35:15 INFO - Running setup.py install for blobuploader 09:35:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:35:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:35:15 INFO - Running setup.py install for requests 09:35:15 INFO - Running setup.py install for docopt 09:35:15 INFO - Successfully installed blobuploader requests docopt 09:35:15 INFO - Cleaning up... 09:35:15 INFO - Return code: 0 09:35:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:15 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 0x7f8089eabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f1c0>, '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 0x18300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1830550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:35:15 INFO - Using env: {'DISPLAY': ':0', 09:35:15 INFO - 'HOME': '/home/cltbld', 09:35:15 INFO - 'LANG': 'en_US.UTF-8', 09:35:15 INFO - 'LANGUAGE': 'en_US:en', 09:35:15 INFO - 'LOGNAME': 'cltbld', 09:35:15 INFO - 'MAIL': '/var/mail/cltbld', 09:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:15 INFO - 'MOZ_NO_REMOTE': '1', 09:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:15 INFO - 'NO_EM_RESTART': '1', 09:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:15 INFO - 'PWD': '/builds/slave/test', 09:35:15 INFO - 'SHELL': '/bin/bash', 09:35:15 INFO - 'SHLVL': '1', 09:35:15 INFO - 'TERM': 'linux', 09:35:15 INFO - 'TMOUT': '86400', 09:35:15 INFO - 'USER': 'cltbld', 09:35:15 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 09:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:15 INFO - '_': '/tools/buildbot/bin/python'} 09:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:35:16 INFO - Running setup.py (path:/tmp/pip-xidF4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:35:16 INFO - Running setup.py (path:/tmp/pip-ZGEb1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:35:16 INFO - Running setup.py (path:/tmp/pip-hGDq7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:35:16 INFO - Running setup.py (path:/tmp/pip-6JuqsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:35:16 INFO - Running setup.py (path:/tmp/pip-1oyk6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:35:16 INFO - Running setup.py (path:/tmp/pip-JL7EZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:35:16 INFO - Running setup.py (path:/tmp/pip-y4TGor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:35:16 INFO - Running setup.py (path:/tmp/pip-PTegFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:35:16 INFO - Running setup.py (path:/tmp/pip-XXqnHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:35:16 INFO - Running setup.py (path:/tmp/pip-Q49BKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:35:16 INFO - Running setup.py (path:/tmp/pip-gxr_fS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:35:16 INFO - Running setup.py (path:/tmp/pip-P8N_y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:35:17 INFO - Running setup.py (path:/tmp/pip-fPfVGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:35:17 INFO - Running setup.py (path:/tmp/pip-xq4gxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:17 INFO - Running setup.py (path:/tmp/pip-vbaWZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:35:17 INFO - Running setup.py (path:/tmp/pip-1mnt2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:35:17 INFO - Running setup.py (path:/tmp/pip-hu28At-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:35:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:35:17 INFO - Running setup.py install for manifestparser 09:35:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:35:17 INFO - Running setup.py install for mozcrash 09:35:17 INFO - Running setup.py install for mozdebug 09:35:17 INFO - Running setup.py install for mozdevice 09:35:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:35:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:35:17 INFO - Running setup.py install for mozfile 09:35:17 INFO - Running setup.py install for mozhttpd 09:35:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:35:18 INFO - Running setup.py install for mozinfo 09:35:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:35:18 INFO - Running setup.py install for mozInstall 09:35:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:35:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:35:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:35:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:35:18 INFO - Running setup.py install for mozleak 09:35:18 INFO - Running setup.py install for mozlog 09:35:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:35:18 INFO - Running setup.py install for moznetwork 09:35:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:35:18 INFO - Running setup.py install for mozprocess 09:35:18 INFO - Running setup.py install for mozprofile 09:35:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:35:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:35:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:35:18 INFO - Running setup.py install for mozrunner 09:35:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:35:18 INFO - Running setup.py install for mozscreenshot 09:35:18 INFO - Running setup.py install for moztest 09:35:19 INFO - Running setup.py install for mozversion 09:35:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:35:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:35:19 INFO - Cleaning up... 09:35:19 INFO - Return code: 0 09:35:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:35: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')]} 09:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35: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')]} 09:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:19 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 0x7f8089eabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f1c0>, '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 0x18300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1830550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:35:19 INFO - Using env: {'DISPLAY': ':0', 09:35:19 INFO - 'HOME': '/home/cltbld', 09:35:19 INFO - 'LANG': 'en_US.UTF-8', 09:35:19 INFO - 'LANGUAGE': 'en_US:en', 09:35:19 INFO - 'LOGNAME': 'cltbld', 09:35:19 INFO - 'MAIL': '/var/mail/cltbld', 09:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:19 INFO - 'MOZ_NO_REMOTE': '1', 09:35:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:19 INFO - 'NO_EM_RESTART': '1', 09:35:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:19 INFO - 'PWD': '/builds/slave/test', 09:35:19 INFO - 'SHELL': '/bin/bash', 09:35:19 INFO - 'SHLVL': '1', 09:35:19 INFO - 'TERM': 'linux', 09:35:19 INFO - 'TMOUT': '86400', 09:35:19 INFO - 'USER': 'cltbld', 09:35:19 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 09:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:19 INFO - '_': '/tools/buildbot/bin/python'} 09:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:35:19 INFO - Running setup.py (path:/tmp/pip-d8JC3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:35:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:35:19 INFO - Running setup.py (path:/tmp/pip-LGiosC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:35:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:35:19 INFO - Running setup.py (path:/tmp/pip-pBD9Yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:35:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:35:19 INFO - Running setup.py (path:/tmp/pip-qjtaI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:35:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:35:19 INFO - Running setup.py (path:/tmp/pip-8L7vTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:35:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:35:19 INFO - Running setup.py (path:/tmp/pip-fC6CLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:35:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:35:19 INFO - Running setup.py (path:/tmp/pip-c0_MHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:35:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:35:19 INFO - Running setup.py (path:/tmp/pip-MoCocB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:35:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:35:19 INFO - Running setup.py (path:/tmp/pip-6RHchW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:35:20 INFO - Running setup.py (path:/tmp/pip-dDJ_fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:35:20 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)) 09:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:35:20 INFO - Running setup.py (path:/tmp/pip-7tTh0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:35:20 INFO - Running setup.py (path:/tmp/pip-bmBVny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:35:20 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)) 09:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:35:20 INFO - Running setup.py (path:/tmp/pip-esUYFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:35:20 INFO - Running setup.py (path:/tmp/pip-gn88tP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:35:20 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)) 09:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:20 INFO - Running setup.py (path:/tmp/pip-56bLqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:35:20 INFO - Running setup.py (path:/tmp/pip-M6E1_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:35:20 INFO - Running setup.py (path:/tmp/pip-oMzFAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:35:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:22 INFO - Downloading blessings-1.6.tar.gz 09:35:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:35:22 INFO - Installing collected packages: blessings 09:35:22 INFO - Running setup.py install for blessings 09:35:22 INFO - Successfully installed blessings 09:35:22 INFO - Cleaning up... 09:35:22 INFO - Return code: 0 09:35:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:35:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:35:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:35:23 INFO - Reading from file tmpfile_stdout 09:35:23 INFO - Current package versions: 09:35:23 INFO - argparse == 1.2.1 09:35:23 INFO - blessings == 1.6 09:35:23 INFO - blobuploader == 1.2.4 09:35:23 INFO - docopt == 0.6.1 09:35:23 INFO - functools32 == 3.2.3-2 09:35:23 INFO - jsonschema == 2.5.1 09:35:23 INFO - manifestparser == 1.1 09:35:23 INFO - mozInstall == 1.12 09:35:23 INFO - mozcrash == 0.17 09:35:23 INFO - mozdebug == 0.1 09:35:23 INFO - mozdevice == 0.48 09:35:23 INFO - mozfile == 1.2 09:35:23 INFO - mozhttpd == 0.7 09:35:23 INFO - mozinfo == 0.9 09:35:23 INFO - mozleak == 0.1 09:35:23 INFO - mozlog == 3.2 09:35:23 INFO - moznetwork == 0.27 09:35:23 INFO - mozprocess == 0.22 09:35:23 INFO - mozprofile == 0.28 09:35:23 INFO - mozrunner == 6.11 09:35:23 INFO - mozscreenshot == 0.1 09:35:23 INFO - mozsystemmonitor == 0.3 09:35:23 INFO - moztest == 0.7 09:35:23 INFO - mozversion == 1.4 09:35:23 INFO - psutil == 3.1.1 09:35:23 INFO - requests == 1.2.3 09:35:23 INFO - wsgiref == 0.1.2 09:35:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:23 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 0x7f8089eabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f1c0>, '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 0x18300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1830550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:35:23 INFO - Using env: {'DISPLAY': ':0', 09:35:23 INFO - 'HOME': '/home/cltbld', 09:35:23 INFO - 'LANG': 'en_US.UTF-8', 09:35:23 INFO - 'LANGUAGE': 'en_US:en', 09:35:23 INFO - 'LOGNAME': 'cltbld', 09:35:23 INFO - 'MAIL': '/var/mail/cltbld', 09:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:23 INFO - 'MOZ_NO_REMOTE': '1', 09:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:23 INFO - 'NO_EM_RESTART': '1', 09:35:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:23 INFO - 'PWD': '/builds/slave/test', 09:35:23 INFO - 'SHELL': '/bin/bash', 09:35:23 INFO - 'SHLVL': '1', 09:35:23 INFO - 'TERM': 'linux', 09:35:23 INFO - 'TMOUT': '86400', 09:35:23 INFO - 'USER': 'cltbld', 09:35:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 09:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:23 INFO - '_': '/tools/buildbot/bin/python'} 09:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:35:23 INFO - Cleaning up... 09:35:23 INFO - Return code: 0 09:35:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8089eabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f1c0>, '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 0x18300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1830550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:35:23 INFO - Using env: {'DISPLAY': ':0', 09:35:23 INFO - 'HOME': '/home/cltbld', 09:35:23 INFO - 'LANG': 'en_US.UTF-8', 09:35:23 INFO - 'LANGUAGE': 'en_US:en', 09:35:23 INFO - 'LOGNAME': 'cltbld', 09:35:23 INFO - 'MAIL': '/var/mail/cltbld', 09:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:23 INFO - 'MOZ_NO_REMOTE': '1', 09:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:23 INFO - 'NO_EM_RESTART': '1', 09:35:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:23 INFO - 'PWD': '/builds/slave/test', 09:35:23 INFO - 'SHELL': '/bin/bash', 09:35:23 INFO - 'SHLVL': '1', 09:35:23 INFO - 'TERM': 'linux', 09:35:23 INFO - 'TMOUT': '86400', 09:35:23 INFO - 'USER': 'cltbld', 09:35:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 09:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:23 INFO - '_': '/tools/buildbot/bin/python'} 09:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:35:23 INFO - Cleaning up... 09:35:23 INFO - Return code: 0 09:35:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8089eabf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182f1c0>, '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 0x18300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1830550>, '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': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:35:23 INFO - Using env: {'DISPLAY': ':0', 09:35:23 INFO - 'HOME': '/home/cltbld', 09:35:23 INFO - 'LANG': 'en_US.UTF-8', 09:35:23 INFO - 'LANGUAGE': 'en_US:en', 09:35:23 INFO - 'LOGNAME': 'cltbld', 09:35:23 INFO - 'MAIL': '/var/mail/cltbld', 09:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:23 INFO - 'MOZ_NO_REMOTE': '1', 09:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:23 INFO - 'NO_EM_RESTART': '1', 09:35:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:23 INFO - 'PWD': '/builds/slave/test', 09:35:23 INFO - 'SHELL': '/bin/bash', 09:35:23 INFO - 'SHLVL': '1', 09:35:23 INFO - 'TERM': 'linux', 09:35:23 INFO - 'TMOUT': '86400', 09:35:23 INFO - 'USER': 'cltbld', 09:35:23 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 09:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:23 INFO - '_': '/tools/buildbot/bin/python'} 09:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:23 INFO - Downloading/unpacking flake8 09:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:35:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:35:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:35:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:35:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:35:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:35:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:35:26 INFO - no previously-included directories found matching 'docs/_build' 09:35:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:35:26 INFO - Running setup.py install for pep8 09:35:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:35:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:35:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:35:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:35:26 INFO - no previously-included directories found matching 'docs/_build' 09:35:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:35:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:35:26 INFO - Cleaning up... 09:35:26 INFO - Return code: 0 09:35:26 INFO - Running post-action listener: _resource_record_post_action 09:35:26 INFO - Running post-action listener: _start_resource_monitoring 09:35:26 INFO - Starting resource monitoring. 09:35:26 INFO - ##### 09:35:26 INFO - ##### Finished create-virtualenv step (success) 09:35:26 INFO - ##### 09:35:26 INFO - ##### 09:35:26 INFO - ##### Running install step. 09:35:26 INFO - ##### 09:35:26 INFO - Running pre-action listener: _resource_record_pre_action 09:35:26 INFO - Running main action method: install 09:35:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:35:26 INFO - Reading from file tmpfile_stdout 09:35:26 INFO - Detecting whether we're running mozinstall >=1.0... 09:35:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:35:26 INFO - Reading from file tmpfile_stdout 09:35:26 INFO - Output received: 09:35:26 INFO - Usage: mozinstall [options] installer 09:35:26 INFO - Options: 09:35:26 INFO - -h, --help show this help message and exit 09:35:26 INFO - -d DEST, --destination=DEST 09:35:26 INFO - Directory to install application into. [default: 09:35:26 INFO - "/builds/slave/test"] 09:35:26 INFO - --app=APP Application being installed. [default: firefox] 09:35:26 INFO - mkdir: /builds/slave/test/build/application 09:35:26 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'] 09:35:26 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 09:35:42 INFO - Reading from file tmpfile_stdout 09:35:42 INFO - Output received: 09:35:42 INFO - /builds/slave/test/build/application/firefox/firefox 09:35:42 INFO - Running post-action listener: _resource_record_post_action 09:35:42 INFO - ##### 09:35:42 INFO - ##### Finished install step (success) 09:35:42 INFO - ##### 09:35:42 INFO - ##### 09:35:42 INFO - ##### Running run-tests step. 09:35:42 INFO - ##### 09:35:42 INFO - Running pre-action listener: _resource_record_pre_action 09:35:42 INFO - Running main action method: run_tests 09:35:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:35:42 INFO - Python 2.7.3 09:35:42 INFO - Return code: 0 09:35:42 INFO - grabbing minidump binary from tooltool 09:35:42 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')]} 09:35:42 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 0x182f1c0>, '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 0x18300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1830550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:35:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:35:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:35:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:35:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:35:42 INFO - Return code: 0 09:35:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:35:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:35:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:35:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:35:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:35:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:35:43 INFO - Return code: 0 09:35:43 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/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 09:35:43 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/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 09:35:43 INFO - Using env: {'DISPLAY': ':0', 09:35:43 INFO - 'HOME': '/home/cltbld', 09:35:43 INFO - 'LANG': 'en_US.UTF-8', 09:35:43 INFO - 'LANGUAGE': 'en_US:en', 09:35:43 INFO - 'LOGNAME': 'cltbld', 09:35:43 INFO - 'MAIL': '/var/mail/cltbld', 09:35:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:35:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:43 INFO - 'MOZ_NO_REMOTE': '1', 09:35:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:35:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:43 INFO - 'NO_EM_RESTART': '1', 09:35:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:43 INFO - 'PWD': '/builds/slave/test', 09:35:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:35:43 INFO - 'SHELL': '/bin/bash', 09:35:43 INFO - 'SHLVL': '1', 09:35:43 INFO - 'TERM': 'linux', 09:35:43 INFO - 'TMOUT': '86400', 09:35:43 INFO - 'USER': 'cltbld', 09:35:43 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462', 09:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:43 INFO - '_': '/tools/buildbot/bin/python'} 09:35:43 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/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 09:35:44 INFO - mozversion application_buildid: 20160617085624 09:35:44 INFO - mozversion application_changeset: 530e96008b7e987c75ddbab59cabdc11f9bbabb9 09:35:44 INFO - mozversion application_display_name: Nightly 09:35:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:35:44 INFO - mozversion application_name: Firefox 09:35:44 INFO - mozversion application_remotingname: firefox 09:35:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:35:44 INFO - mozversion application_vendor: Mozilla 09:35:44 INFO - mozversion application_version: 50.0a1 09:35:44 INFO - mozversion platform_buildid: 20160617085624 09:35:44 INFO - mozversion platform_changeset: 530e96008b7e987c75ddbab59cabdc11f9bbabb9 09:35:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:35:44 INFO - mozversion platform_version: 50.0a1 09:35:44 INFO - using testdate: 1466181344 09:35:44 INFO - actual date: 1466181344 09:35:44 INFO - starting webserver on 'localhost:52173' 09:35:44 INFO - SUITE-START | Running 2 tests 09:35:44 INFO - TEST-START | dromaeo_css 09:35:44 INFO - operating with platform_type : linux_ 09:35:44 INFO - Initialising browser for dromaeo_css test... 09:35:44 INFO - TEST-INFO | started process 8785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYYONDO/profile http://localhost:52173/getInfo.html) 09:35:49 INFO - PROCESS | 8785 | __metrics Screen width/height:1600/1200 09:35:49 INFO - PROCESS | 8785 | colorDepth:24 09:35:49 INFO - PROCESS | 8785 | Browser inner width/height: 1024/697 09:35:49 INFO - PROCESS | 8785 | __metrics 09:35:49 ERROR - PROCESS | 8785 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 09:35:50 INFO - TEST-INFO | 8785: exit 0 09:35:50 INFO - Browser initialized. 09:35:50 INFO - Running cycle 1/1 for dromaeo_css test... 09:35:50 INFO - TEST-INFO | started process 8906 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYYONDO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:03 INFO - PROCESS | 8906 | RSS: Main: 185942016 09:36:03 INFO - PROCESS | 8906 | 09:36:52 INFO - PROCESS | 8906 | 1466181412625 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:39:05 INFO - PROCESS | 8906 | Cycle 1(1): loaded http://localhost:52173/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52173/tests/dromaeo/cssquery-ext.html) 09:39:06 INFO - PROCESS | 8906 | RSS: Main: 186884096 09:39:06 INFO - PROCESS | 8906 | 09:42:08 INFO - PROCESS | 8906 | Cycle 1(1): loaded http://localhost:52173/tests/dromaeo/cssquery-ext.html (next: http://localhost:52173/tests/dromaeo/cssquery-jquery.html) 09:42:09 INFO - PROCESS | 8906 | RSS: Main: 187695104 09:42:09 INFO - PROCESS | 8906 | 09:45:11 INFO - PROCESS | 8906 | Cycle 1(1): loaded http://localhost:52173/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52173/tests/dromaeo/cssquery-mootools.html) 09:45:11 INFO - PROCESS | 8906 | RSS: Main: 188751872 09:45:11 INFO - PROCESS | 8906 | 09:48:13 INFO - PROCESS | 8906 | Cycle 1(1): loaded http://localhost:52173/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52173/tests/dromaeo/cssquery-prototype.html) 09:48:14 INFO - PROCESS | 8906 | RSS: Main: 186040320 09:48:14 INFO - PROCESS | 8906 | 09:51:17 INFO - PROCESS | 8906 | Cycle 1(1): loaded http://localhost:52173/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52173/tests/dromaeo/cssquery-yui.html) 09:51:17 INFO - PROCESS | 8906 | RSS: Main: 188444672 09:51:17 INFO - PROCESS | 8906 | 09:54:20 INFO - PROCESS | 8906 | Cycle 1(1): loaded http://localhost:52173/tests/dromaeo/cssquery-yui.html (next: http://localhost:52173/tests/dromaeo/cssquery-dojo.html) 09:54:20 INFO - PROCESS | 8906 | RSS: Main: 189362176 09:54:20 INFO - PROCESS | 8906 | 09:54:20 INFO - PROCESS | 8906 | __start_tp_report 09:54:20 INFO - PROCESS | 8906 | _x_x_mozilla_page_load 09:54:20 INFO - PROCESS | 8906 | _x_x_mozilla_page_load_details 09:54:20 INFO - PROCESS | 8906 | |i|pagename|runs| 09:54:20 INFO - PROCESS | 8906 | |0;dojo.html;2608.660874086369;2697.8246413983097;2707.025470830502;2711.9864400677993;2726.6455360803093;4793.065352256307;4841.0801947629925;4866.902661946763;4937.5309345612195;4994.250862370646;4704.952950470494;4830.613550915927;4861.562459378655;4868.29409735589;4868.878278043051;4376.343548467739;4410.338449232609;4528.9094218115615;4546.249868771649;4563.657725670588;613.727777232953;4342.652587792984;4438.4895736990175;4454.13144436835;4484.1928452878465;4478.507364189936;4493;4503.977480112611;4510.684252102355;4526.072155208174;4503.932441013388;4511.210538155809;4517.028838799673;4541.409616749835;4555.180067587833;4372.956270437287;4376.299792033259;4388.275934470808;4397.362382454527;4456.997175635489;4763.214069678499;4860.538248866352;4868.634852386085;4899.55903968641;4907.607391408679;5193.2989046479;5226.477352264781;5245.055889939809;5259.158534634478;5324.653897496651;5271.947280527223;5308.964751873386;5314.229436731691;5324.334458192726;5354.063038968204;4882.877928051792;4927.236278376858;4933;4933.6299777516115;4942.28336891156;5283.920741188886;5322.0952438085615;5346.866328341823;5371.75827087782;5395.649282796606;5142.228665700175;5167.044096842096;5167.586593072545;5177.663451875691;5207.453217412193;5250.448702886219;5259.552938000236;5263.157894736823;5263.7104959226845;5309.548688361455;4993.400791904922;5065.214891691794;5115.616328775357;5190.169572868398;5197.896042079137;5112.846614601568;5185.662931909414;5201.5838732901275;5210.088234558937;5227.947720522822;4476.888077798081;4485.0581377911;4489.281714925596;4527.501974782771;4528.456585209796;3793.943090853639;3828.789416582115;3840.615938406137;3871.4192871069563;3903.980480097581;4440.089781594766;4455.465344158657;4469.865904022885;4500.212462818994;4574.016586433932;5229.581633469314;5229.738513074407;5254.789808407697;5272.92090618641;5275.947240527546;4402.603765661106;4476.597106260452;4499.6400287976885;4515.63874890008;4523.977380113144;4726.976365118152;4756.453007904135;4769.2130798417875;4776.355192049098;4806.375171227718;4915.21356582945;4951.1088004158155;4966.503349665005;4966.776495057803;5001.549860512571;5091.898162036665;5135.717535535432;5151.871203219799;5157.07172708901;5224.660397074178;4885.316055752127;4888.462269150462;4903;4918.926216106833;4932.087563800565;5147.047796157723;5149.201873709581;5156.5616922562;5201.92197117036;5216.817411390583;5078.923816142835;5213.400458947118;5230.849213173095;5267.2889159962915;5278.5249327560705;5128.12821820284;5137.049645815536;5137.92293115611;5150.072986862401;5168;5105.387353517602;5113.821016264413;5125.69294829816;5129.051125541787;5180.533751962342;4907.55831975124;4948.8762780930765;5026.421961474331;5051.217061355495;5052.115879721107;5132.5124113209185;5156.355455568054;5160.638755287094;5163.432022477449;5174.379074511083;5059.342285502861;5066.113430149635;5066.468020857904;5072.391313042459;5098.439171691037 09:54:20 INFO - PROCESS | 8906 | |1;ext.html;541.5771265575161;583.2650859916505;587.0900104837503;599.5623195067601;611.1352436302632;34762;38162.8091859541;38169.23661526768;38239.23521529571;38337.04157396063;38483.23033539327;39263.80368098155;39269.803650981776;39297.607023929755;39334.21331573374;7701.4608977371745;7809.492382995116;7844.372450203999;7846.293833554979;7874.960625196894;7789.376849852027;7806.726764563241;7852.685892564291;7876.369890408753;7888.487248328869;7912.129665736765;7917.604119794016;7935.960320198391;7937.682492700285;7956.880646790303;7857.096433910087;7866.292033716993;7889.408294377945;7904;7908.683652653945;7756.612169391507;7818.4136189785995;7823.8435231295625;7871.8032049198655;7874.803129921741;36370;36661.633383666085;36676.44985325222;36813;36933.81533092344;3202.503611940153;3407.148212946763;3534.2401383702627;3675.099600597844;3773.7735735855663;28863;28929.710702892913;29288.560671589945;29508.40983180346;29774.55338169929;3489.319582681378;3491.546099007113;3540.8583656653705;3619.2580520993133;3671.467637192619;251464;252660;252798;253715;253839.73080134665;30749.231269218002;31551.36897262088;31691.84154079215;50986;51734.48265517372;33339.66660333414;33350.49974250388;33744.83127584396;33761.32477350439;33776.49335259973;12491.687707807196;12661;12692.746145077046;12709.872901271054;12710.364481775874;10470.581176752998;10595.417252051211;10599.523021464052;10615.363078215332;10672.039516443558;7775.688972441039;7931.920680793233;7943.602819859099;7966.243206895336;7982.042154941328;3165.5409965554863;3178.507331363642;3194.552762613236;3202.4715921873094;3210.967890321114;858.4420126917554;968.5883499512679;984.3749219245688;1028.5114570579065;1029.3669393323053;28207.43585128286;28233.576496352573;28266.717332826818;28601;28764.280892977844;972.1445128287204;979.480875136179;992.0327680511443;1028.3624153025023;1038.5326603028516;14881;14930.25348732559;15077.321520531603;15106.320215590325;15280.617984550476;371144;373112;374489;375144;375220;48147.518524815;48486.27270590944;48623.513764862604;48624.75687621539;48654.75672621614;1171.472837223236;1188.6849984754047;1203.620859429277;1213.5206593395735;1219.2379762648345;26815.865920670272;27425;27448.862755686092;27886;28287;42203;42314.36528452014;42607.57392426036;42669.57330426656;42761.786191068844;323509;324816.87957801245;325804;325810;326160;24984.125555605468;25047;25151.49697006013;25236.74763252344;25388.238352849443;41196.38205426861;41515;41856.58143418527;42104.78947605365;42278.788606056776;35718.46422303616;35907;36165.457518136725;36301;36736;36203.29566008164;36663.816680916425;36895.44656830096;37083.6291637091;37477;32574.34851303008;35820.820895895355;36091;36412.45381319335;39912.60087399089;31364.37271254608;32753.50869736908;32851.178720532174;32945.835270823496;33124.834375827966;25319.873400632878;25472.108476203244;25534.872325638255;25569.23292301234;25675.871620642523 09:54:20 INFO - PROCESS | 8906 | |2;jquery.html;363.64362924334137;365.53029357275886;369.7929159670585;374.52996489405825;376.77770115631773;16642.334306627734;17054.573635659115;17622.911885440586;17869.910650446745;17876.82123178768;16163.353465861352;16609.501714948572;17278.740818887694;17293.740593891103;17320.740188897144;4907.975460122694;5071.112555302826;5125.282460455539;5129.333186685725;5130.3074084998425;3691.2432951245064;5050.292958985727;5590.440955904397;6017.217761690974;6018.127371531125;5972.19375384324;6005.279366476029;6027.849303767419;6037.6075555089;6074.453299203071;5888.676122813244;6003.6697981611;6059.424354686298;6066.939330606704;6077.602151505156;5280.630355875091;5290.55030322423;5302.2046692996355;5307.416184219733;5365.436629153922;21241.25655602062;21299.949745493377;21423.67864482034;21521.677174842232;21968.121275149133;1882.4634979031048;1953.3846838245906;1962.4014675523958;2032.573159636478;2132.4455641533314;12939.870601294055;13149.737005259936;13652.180869147884;13697.931510342483;13824.516141934984;1771.68109740248;1772.344232633921;1785.544686105048;1792;1796.4161647464625;44098.77950610258;67650;67904.3209567903;68003.65998170027;68265.65867170681;9603.279754018477;9946.502674866228;9992.65025724096;10143.898561014443;10670.51982660782;13415.932920335532;13429.731405372033;13535.32323383827;13633;13709.17744935307;6901.344372284625;7054.75308364215;7145.321194486515;7163.785086447415;7256.4194864411775;6849.212340580797;6895.448364130857;6924.342187492281;7118.113699869538;7131.607761573059;6061.272647282354;6517.576357536745;6549.279579246279;6634.303398143222;6778.423833974168;1599.224376177553;1715.6054107555333;1756.8770186087106;1781.6080462298273;1799.8290162434548;799.5922079739258;830.5556527257888;846.3187134356901;935.3686261773275;968.1238479176357;15601.609959751097;16803.495895123167;17125.14374281281;17169.399071032454;17627;816.542736067804;862.3187681731488;876.2157868707599;908.246155690775;910.7814124610046;9129.81740365189;9539;9544.52277386128;9548.236141108695;9794.951025244829;295947;300114;426479;431987;435076;80009.59995199987;82507.17492825114;84298.57850710707;84948;85256.57371713102;879.5470332778624;903.503073309677;933.6452148183647;933.8552524358736;949.8575213717997;15842.494962978499;15949.681006379575;16056.19719014068;16126.193690315202;16518.83481165173;26104.8694756525;26375.34061648474;37260.254794903405;37566;38575.42136868005;52881;53484.197737033195;53552.73223633857;53607.46392536024;53877.46122538725;7534.133574638987;7605.087389513294;7643.426742994409;7748.496347737379;7771.33943614799;11255.943720281346;11972.982296504895;11997.160198786001;12026.639200823989;12230.266184028631;4992.675476094042;7958.761237162895;10392.636257730943;10679.46602669848;10785.245032847939;10217.182625389802;10243.334183278062;10254.846177307496;10324.380537167794;10643.361398316125;9955.352902061342;10160.390376577428;10368.911264317137;10616.681499555025;10957.83563246568;7426.962865185639;7455.813604659927;7503.887441688488;7613.581253031137;7739.264769846855;9872.506374681094;9935.20518358544;10124.190064794651;10426.739331516772;10495.632652857113 09:54:20 INFO - PROCESS | 8906 | |3;mootools.html;1354.356680576726;1404.262762049924;1482.733108040553;1636.582671418788;1682.2429906542052;6841.555298905568;7412.184659687437;7590.962045189766;7949.364050875931;8068.435209535335;7683.270089341504;7715.459917805756;7835.764927052198;7872.448928575002;7888.250616191467;2199.164317559329;2207.75714671386;2231.129859354853;2235.865848049114;2246.3934737620834;2158.7625361210253;2214.081156320125;2235.653473711577;2250.4261413339577;2258.8080013198896;2217.756046834847;2222.4777177363308;2227.365200917731;2228.3871935217862;2229.1194977983687;2118.078635793427;2121.9363419097454;2125.234915430444;2131.7548481924623;2134.2423439678846;2122.1193204819983;2162.4485756132244;2173.7065496157975;2187.0377034105104;2187.8359123065834;7803.531788092732;7853.528788272665;7900.091489478726;7916.841663166762;8010.158933311976;4515.729056256635;4602.217623004064;4609.423822022247;4610.76946152691;4635.46692130406;2807.5507918732906;2901.5937768712397;2935.1194641607644;2938.9853050734823;2965.0956458280216;864.2912811494577;889.8976617688984;895.5208963204655;900.3652425040331;926.4487629860222;10387.169026477864;10506.212034097472;10572.947135264274;10577.31247468912;10671.306365086244;4140.130572579792;4191.517975432804;4266.658667306608;4275.337322714984;4302.634276086567;8950.731478055668;9006.234470069987;9031.593578288992;9078.86381704275;9080.22818060459;4392.472903251631;4440.844570440019;4447.066116115588;4448.7108337957925;4480.663950203748;3626.5285512883156;4079.265732168179;4090.877273681794;4093.5701751315682;4259.233337999128;3653.762505437138;3680.8895733128047;3747.4191500317493;3793.241351729665;3847.3844184930276;1180.6753142885602;1185.7569198314325;1186.7507823357018;1192.5170306026073;1196.6469891382062;801.6753214947955;817.4196320612432;820.5856042698518;824.2220353237944;826.0871736730946;4913.803447862117;5061.4179369373;5083.898322033612;5254.448282930313;5281.075811733008;394.3847597747523;410.9157622687402;410.9773962432035;412.44320167773265;412.53177643374386;3787.2046870157023;3940.704447166474;3946.6645335146836;4008.398740188995;4017.9397309040387;9567.952160239154;9803.558839852223;9840.507974601242;9873.308868379145;9910.45492497905;9245.445273283625;9560.426374417557;9593.904060959301;9672;9822.410655360702;7275.636218189069;7336.559806411632;7339.192688804227;7418.146913104954;7462.02993610838;5060.291559181644;5218.464724094286;5240.187770895517;5328.387235467971;5498.642588231752;8842;8909.420887642282;9128.49793261377;9201.447913125234;9208.539573021457;9143.679971200976;9230.815383692423;9282.62869485213;9301.813963720822;9319.114684105;6246.531510136667;6535.3137920517665;6568.310327415744;6673.866522669617;6687.732490700318;7315.707371705073;7338.119425668954;7355.5586664800285;7413.147488038729;7444.404447644284;6529.347065293433;6796.116504854337;6848.726050958106;6885.345892140439;6910;6438.420542151041;6503.6097834130105;6574.211094668671;6636.800895973129;6671;5808.796692115925;5816.040353341651;5818.970905145447;5820.097884827858;5860.970695146668;4227.97886010568;4246.808893599858;4372.256716358163;4406.559344065696;4480.39514665516;4441.356003379557;4472.9552704472535;4512.210363186495;4597.7011494252765;4656.138614356355 09:54:20 INFO - PROCESS | 8906 | |4;prototype.html;295.54043462415933;298.2662649881292;299.83658905896283;301.05768943207755;304.7227023408698;5163.870903227421;5199.922001169981;5213.635045546814;5233.816816411421;5246.816361427342;5062.594992400608;5107.7701503432345;5116.590672746181;5122.974385128078;5156.948430515694;3767.3595488766973;3881;3975.6223158799867;3976.6023397660147;3997.2405243003736;3997.4203740457615;4004.679625629957;4029.07331313798;4029.4761680981433;4054.1891621675636;3982.6017398260087;3994.820233089518;4002.8598999034893;4022.4368588397647;4028.738132021409;3709.7774133552075;3942.664873485757;3955.20895820837;3989.2221016901717;4028.1742242840146;3411.2665776858094;3421.6920477157178;3428.8114153721535;3438.48422736589;3440.7419443541585;4911.361523002022;4951.876203094916;4967.82612608557;5003.399592048978;5025.899482010339;4176.415301857743;4503.549645035503;4518.096380723836;4527.479339875924;4528.50186479487;5256.92114618281;5297.602679798992;5333.839984800462;5368.70472124033;5383.73081345935;3692.095436618019;3695.447911877018;3703.666669999713;3711.1464363196615;3726.1988672435286;5425.9186112208345;5654.331972068249;5654.6324488908085;5685.772569097231;5695.45893140151;3785.337565926007;3795.905102372463;3823.2544653792243;3824.541055073409;3832.7317087804145;3902.1415288636454;3920.7843568604;3921.941170882439;3923.509561304837;3927.3323534999117;4510.345999830072;4514.864554063383;4542.9772851136195;4546.204414227497;4551.431071116111;5295.285136506599;5315.335583052119;5405.702686352289;5427.565794736412;5459.481349271813;1311.9278439685909;1332.8933685305153;1335.7528857161456;1340.1088276296348;1342.838859336886;835.5362773660677;847.6099197316406;851.7785375802335;857.2070834478083;869.7173418638968;4545.886352841206;4604.595598342537;4614.10025045113;4633.2818413146015;4658.254679251371;5418.539424148913;5450.618456707993;5459.645123066988;5470.370907345706;5472.480114389126;4486.349479325545;4573.108243892476;4591.242444996605;4606.700564463366;4645.117427688729;2906.1717410537894;2947.410517896429;2949.985250073736;2958.4083183363414;2960.555916612482;5101.34206382927;5116.334876466036;5134.563562097189;5135.460776618401;5140.948590514122;5438.096666166889;5589.888202235932;5590.776368945278;5599.356074051536;5600.467955544217;5132.563732082815;5143.408508021551;5156.1750119980625;5156.871078222925;5162.5286793264495;5451.836444906659;5453.464139175302;5493.395726470005;5497.36780270274;5512.932650256154;5067.822626208213;5357.116075847442;5368.2752828367675;5379.623426360117;5384.542313903362;5078.542931136216;5117.8720531987;5121;5130.461301563282;5135.948640513547;3749.6625303722794;3794.6774524164653;3871.438641397038;3878.069263376826;3887.3197190492115;5305.1776974569;5431.131019036935;5450.563954883521;5453.400125986059;5506.834794956158;5323.547498462674;5332.78668853257;5340.652857564246;5348.919766203432;5381.461853814587;5068.746562671926;5302.8939421212135;5304.761285742228;5327.696827966685;5339.3058902342445;5294.841154765363;5308.469153084815;5312.150055991177;5336.813211537577;5342.332208473941;5240.71176085319;5323.787048518171;5519.420460851713;5526.41972592888;5542.279503664659;5357.598180136583;5374.973125134506;5379.946200537945;5392.568594512508;5424.376196737426 09:54:20 INFO - PROCESS | 8906 | |5;yui.html;645.777206863632;679.2392520377178;689.5207830557764;722.0577146823395;740.4853626729418;12257.14200006;13296;13299.135556188841;13452.394642241099;13588.184708917448;13235.33823308833;13327.60017199483;13430.865691343084;13465.46138154475;13534.187948723058;622.7695752571555;763.076677220561;772.7758949904521;799.188823344306;803.8432505661399;793.6666600027974;794.0590400375545;795.1571334385541;797.9680812767482;804.0512195609178;826.446280991737;827.3050637464529;834.3367023216557;836.5440834745048;839.1734141870284;807.6728924785472;814.6293436486385;815.0708192660372;824.4146655874276;826.277007618334;596.6092209602717;604.607005446459;606.2240332374568;608.1728848765675;608.4706305514231;13570.728585428236;13834.792478112837;13880.236586987712;13941.721165576631;13958.232297223649;13563.254021028839;13626.591202263948;13801.51694690691;13835.100718453268;14031.649208769863;10705.678829635046;10948.233623646347;10954.835677464844;10994.505247263813;11002.614908478245;3383.188034871613;3416.6754158354915;3425.469052296898;3445.638207988175;3470.5661792275964;65986.67006664936;66582.66708666425;66666.33333666698;66807.33192668059;67275.66362168206;11105.38920359388;11134.554617815358;11233.269837460539;11363;11516.30902145874;21213.15147394087;21215;21335;21774.564508709736;21819.345419637437;6587.308332625101;6597.571157874723;6696.5647232929705;6734.629595372204;6911.03245545624;3728.3102626014274;3732.197577520846;3819.0834199792407;3820.8089595520114;3898.5126859142606;2818.126380821952;3133.4516459619476;3280.868765249411;3295.4562497188176;3340.1148695595684;539.8893226888479;543.9700816455054;544.4174733035693;544.7957016118955;546.8632841789553;493.1370102320938;497.96737866393835;522.5532169994676;523.8926020165857;528.9973550132224;7997;8021.2379823916635;8235.711750088718;8333.916660833434;8438.324934005388;414.41774307098575;437.4094971788061;467.71235690051054;499.21872269897494;504.7198804663447;3845.9807700961874;3917.5298964124486;3990.521137463523;4045.2516284487465;4097.692673049533;101545;104456.47771761092;105143;106242.46878765557;108437;53302.173544741134;86877;88088;88290.55854720814;88880;54109;76276.23723762692;76677.233227667;79901;81210;7447.88828167567;7478.2895624915545;7507.211742767149;7596.278353556403;7643.694252230071;33497.16257093592;46183.76908115438;47524.52475475201;48331.275030875266;48559;53183;54710.72644636752;55708.442915570326;57950.420495794504;61350.69324653348;11283.435828208721;11409.771804563696;11454.312741235553;11455.109906865275;11501.367424791382;12863.742725145257;12978;13037.674058148243;13203.603891883258;13258.138221015603;11910;11972.880271197177;12148.514059437524;12189.69525761863;12288.385580721108;11671.299722016705;12020.75958480843;12455.875441245835;12501.374931253218;12507.624771256877;11407.315561066363;11876.940615296868;11984.40077996114;12212.877871221173;12230.755384892074;10095.596176152872;10196.745081373025;10306.690799276033;10464.00591943764;10596.417197054236;9665.951670241886;9922.255830812574;10019.649312274036;10113.59545618167;10199.7450063749 09:54:20 INFO - PROCESS | 8906 | __end_tp_report 09:54:20 INFO - PROCESS | 8906 | __start_cc_report 09:54:20 INFO - PROCESS | 8906 | _x_x_mozilla_cycle_collect,387 09:54:20 INFO - PROCESS | 8906 | __end_cc_report 09:54:20 INFO - PROCESS | 8906 | __startTimestamp1466182460839__endTimestamp 09:54:20 INFO - PROCESS | 8906 | 09:54:20 INFO - PROCESS | 8906 | ------- Summary: start ------- 09:54:20 INFO - PROCESS | 8906 | Number of tests: 6 09:54:20 INFO - PROCESS | 8906 | 09:54:20 INFO - PROCESS | 8906 | [#0] dojo.html Cycles:165 Average:4808.03 Median:4966.50 stddev:611.90 (12.3%) stddev-sans-first:588.95 09:54:20 INFO - PROCESS | 8906 | Values: 2608.7 2697.8 2707.0 2712.0 2726.6 4793.1 4841.1 4866.9 4937.5 4994.3 4705.0 4830.6 4861.6 4868.3 4868.9 4376.3 4410.3 4528.9 4546.2 4563.7 613.7 4342.7 4438.5 4454.1 4484.2 4478.5 4493.0 4504.0 4510.7 4526.1 4503.9 4511.2 4517.0 4541.4 4555.2 4373.0 4376.3 4388.3 4397.4 4457.0 4763.2 4860.5 4868.6 4899.6 4907.6 5193.3 5226.5 5245.1 5259.2 5324.7 5271.9 5309.0 5314.2 5324.3 5354.1 4882.9 4927.2 4933.0 4933.6 4942.3 5283.9 5322.1 5346.9 5371.8 5395.6 5142.2 5167.0 5167.6 5177.7 5207.5 5250.4 5259.6 5263.2 5263.7 5309.5 4993.4 5065.2 5115.6 5190.2 5197.9 5112.8 5185.7 5201.6 5210.1 5227.9 4476.9 4485.1 4489.3 4527.5 4528.5 3793.9 3828.8 3840.6 3871.4 3904.0 4440.1 4455.5 4469.9 4500.2 4574.0 5229.6 5229.7 5254.8 5272.9 5275.9 4402.6 4476.6 4499.6 4515.6 4524.0 4727.0 4756.5 4769.2 4776.4 4806.4 4915.2 4951.1 4966.5 4966.8 5001.5 5091.9 5135.7 5151.9 5157.1 5224.7 4885.3 4888.5 4903.0 4918.9 4932.1 5147.0 5149.2 5156.6 5201.9 5216.8 5078.9 5213.4 5230.8 5267.3 5278.5 5128.1 5137.0 5137.9 5150.1 5168.0 5105.4 5113.8 5125.7 5129.1 5180.5 4907.6 4948.9 5026.4 5051.2 5052.1 5132.5 5156.4 5160.6 5163.4 5174.4 5059.3 5066.1 5066.5 5072.4 5098.4 09:54:20 INFO - PROCESS | 8906 | 09:54:20 INFO - PROCESS | 8906 | [#1] ext.html Cycles:180 Average:45786.90 Median:19911.28 stddev:84666.59 (425.2%) stddev-sans-first:84835.95 09:54:20 INFO - PROCESS | 8906 | Values: 541.6 583.3 587.1 599.6 611.1 34762.0 38162.8 38169.2 38239.2 38337.0 38483.2 39263.8 39269.8 39297.6 39334.2 7701.5 7809.5 7844.4 7846.3 7875.0 7789.4 7806.7 7852.7 7876.4 7888.5 7912.1 7917.6 7936.0 7937.7 7956.9 7857.1 7866.3 7889.4 7904.0 7908.7 7756.6 7818.4 7823.8 7871.8 7874.8 36370.0 36661.6 36676.4 36813.0 36933.8 3202.5 3407.1 3534.2 3675.1 3773.8 28863.0 28929.7 29288.6 29508.4 29774.6 3489.3 3491.5 3540.9 3619.3 3671.5 251464.0 252660.0 252798.0 253715.0 253839.7 30749.2 31551.4 31691.8 50986.0 51734.5 33339.7 33350.5 33744.8 33761.3 33776.5 12491.7 12661.0 12692.7 12709.9 12710.4 10470.6 10595.4 10599.5 10615.4 10672.0 7775.7 7931.9 7943.6 7966.2 7982.0 3165.5 3178.5 3194.6 3202.5 3211.0 858.4 968.6 984.4 1028.5 1029.4 28207.4 28233.6 28266.7 28601.0 28764.3 972.1 979.5 992.0 1028.4 1038.5 14881.0 14930.3 15077.3 15106.3 15280.6 371144.0 373112.0 374489.0 375144.0 375220.0 48147.5 48486.3 48623.5 48624.8 48654.8 1171.5 1188.7 1203.6 1213.5 1219.2 26815.9 27425.0 27448.9 27886.0 28287.0 42203.0 42314.4 42607.6 42669.6 42761.8 323509.0 324816.9 325804.0 325810.0 326160.0 24984.1 25047.0 25151.5 25236.7 25388.2 41196.4 41515.0 41856.6 42104.8 42278.8 35718.5 35907.0 36165.5 36301.0 36736.0 36203.3 36663.8 36895.4 37083.6 37477.0 32574.3 35820.8 36091.0 36412.5 39912.6 31364.4 32753.5 32851.2 32945.8 33124.8 25319.9 25472.1 25534.9 25569.2 25675.9 09:54:20 INFO - PROCESS | 8906 | 09:54:20 INFO - PROCESS | 8906 | [#2] jquery.html Cycles:180 Average:24177.11 Median:5021.48 stddev:63467.26 (1263.9%) stddev-sans-first:63620.12 09:54:20 INFO - PROCESS | 8906 | Values: 363.6 365.5 369.8 374.5 376.8 16642.3 17054.6 17622.9 17869.9 17876.8 16163.4 16609.5 17278.7 17293.7 17320.7 4908.0 5071.1 5125.3 5129.3 5130.3 3691.2 5050.3 5590.4 6017.2 6018.1 5972.2 6005.3 6027.8 6037.6 6074.5 5888.7 6003.7 6059.4 6066.9 6077.6 5280.6 5290.6 5302.2 5307.4 5365.4 21241.3 21299.9 21423.7 21521.7 21968.1 1882.5 1953.4 1962.4 2032.6 2132.4 12939.9 13149.7 13652.2 13697.9 13824.5 1771.7 1772.3 1785.5 1792.0 1796.4 44098.8 67650.0 67904.3 68003.7 68265.7 9603.3 9946.5 9992.7 10143.9 10670.5 13415.9 13429.7 13535.3 13633.0 13709.2 6901.3 7054.8 7145.3 7163.8 7256.4 6849.2 6895.4 6924.3 7118.1 7131.6 6061.3 6517.6 6549.3 6634.3 6778.4 1599.2 1715.6 1756.9 1781.6 1799.8 799.6 830.6 846.3 935.4 968.1 15601.6 16803.5 17125.1 17169.4 17627.0 816.5 862.3 876.2 908.2 910.8 9129.8 9539.0 9544.5 9548.2 9795.0 295947.0 300114.0 426479.0 431987.0 435076.0 80009.6 82507.2 84298.6 84948.0 85256.6 879.5 903.5 933.6 933.9 949.9 15842.5 15949.7 16056.2 16126.2 16518.8 26104.9 26375.3 37260.3 37566.0 38575.4 52881.0 53484.2 53552.7 53607.5 53877.5 7534.1 7605.1 7643.4 7748.5 7771.3 11255.9 11973.0 11997.2 12026.6 12230.3 4992.7 7958.8 10392.6 10679.5 10785.2 10217.2 10243.3 10254.8 10324.4 10643.4 9955.4 10160.4 10368.9 10616.7 10957.8 7427.0 7455.8 7503.9 7613.6 7739.3 9872.5 9935.2 10124.2 10426.7 10495.6 09:54:20 INFO - PROCESS | 8906 | 09:54:20 INFO - PROCESS | 8906 | [#3] mootools.html Cycles:180 Average:5109.81 Median:4987.05 stddev:2893.41 (58.0%) stddev-sans-first:2887.76 09:54:20 INFO - PROCESS | 8906 | Values: 1354.4 1404.3 1482.7 1636.6 1682.2 6841.6 7412.2 7591.0 7949.4 8068.4 7683.3 7715.5 7835.8 7872.4 7888.3 2199.2 2207.8 2231.1 2235.9 2246.4 2158.8 2214.1 2235.7 2250.4 2258.8 2217.8 2222.5 2227.4 2228.4 2229.1 2118.1 2121.9 2125.2 2131.8 2134.2 2122.1 2162.4 2173.7 2187.0 2187.8 7803.5 7853.5 7900.1 7916.8 8010.2 4515.7 4602.2 4609.4 4610.8 4635.5 2807.6 2901.6 2935.1 2939.0 2965.1 864.3 889.9 895.5 900.4 926.4 10387.2 10506.2 10572.9 10577.3 10671.3 4140.1 4191.5 4266.7 4275.3 4302.6 8950.7 9006.2 9031.6 9078.9 9080.2 4392.5 4440.8 4447.1 4448.7 4480.7 3626.5 4079.3 4090.9 4093.6 4259.2 3653.8 3680.9 3747.4 3793.2 3847.4 1180.7 1185.8 1186.8 1192.5 1196.6 801.7 817.4 820.6 824.2 826.1 4913.8 5061.4 5083.9 5254.4 5281.1 394.4 410.9 411.0 412.4 412.5 3787.2 3940.7 3946.7 4008.4 4017.9 9568.0 9803.6 9840.5 9873.3 9910.5 9245.4 9560.4 9593.9 9672.0 9822.4 7275.6 7336.6 7339.2 7418.1 7462.0 5060.3 5218.5 5240.2 5328.4 5498.6 8842.0 8909.4 9128.5 9201.4 9208.5 9143.7 9230.8 9282.6 9301.8 9319.1 6246.5 6535.3 6568.3 6673.9 6687.7 7315.7 7338.1 7355.6 7413.1 7444.4 6529.3 6796.1 6848.7 6885.3 6910.0 6438.4 6503.6 6574.2 6636.8 6671.0 5808.8 5816.0 5819.0 5820.1 5861.0 4228.0 4246.8 4372.3 4406.6 4480.4 4441.4 4473.0 4512.2 4597.7 4656.1 09:54:20 INFO - PROCESS | 8906 | 09:54:20 INFO - PROCESS | 8906 | [#4] prototype.html Cycles:180 Average:4422.02 Median:5112.05 stddev:1301.79 (25.5%) stddev-sans-first:1268.06 09:54:20 INFO - PROCESS | 8906 | Values: 295.5 298.3 299.8 301.1 304.7 5163.9 5199.9 5213.6 5233.8 5246.8 5062.6 5107.8 5116.6 5123.0 5156.9 3767.4 3881.0 3975.6 3976.6 3997.2 3997.4 4004.7 4029.1 4029.5 4054.2 3982.6 3994.8 4002.9 4022.4 4028.7 3709.8 3942.7 3955.2 3989.2 4028.2 3411.3 3421.7 3428.8 3438.5 3440.7 4911.4 4951.9 4967.8 5003.4 5025.9 4176.4 4503.5 4518.1 4527.5 4528.5 5256.9 5297.6 5333.8 5368.7 5383.7 3692.1 3695.4 3703.7 3711.1 3726.2 5425.9 5654.3 5654.6 5685.8 5695.5 3785.3 3795.9 3823.3 3824.5 3832.7 3902.1 3920.8 3921.9 3923.5 3927.3 4510.3 4514.9 4543.0 4546.2 4551.4 5295.3 5315.3 5405.7 5427.6 5459.5 1311.9 1332.9 1335.8 1340.1 1342.8 835.5 847.6 851.8 857.2 869.7 4545.9 4604.6 4614.1 4633.3 4658.3 5418.5 5450.6 5459.6 5470.4 5472.5 4486.3 4573.1 4591.2 4606.7 4645.1 2906.2 2947.4 2950.0 2958.4 2960.6 5101.3 5116.3 5134.6 5135.5 5140.9 5438.1 5589.9 5590.8 5599.4 5600.5 5132.6 5143.4 5156.2 5156.9 5162.5 5451.8 5453.5 5493.4 5497.4 5512.9 5067.8 5357.1 5368.3 5379.6 5384.5 5078.5 5117.9 5121.0 5130.5 5135.9 3749.7 3794.7 3871.4 3878.1 3887.3 5305.2 5431.1 5450.6 5453.4 5506.8 5323.5 5332.8 5340.7 5348.9 5381.5 5068.7 5302.9 5304.8 5327.7 5339.3 5294.8 5308.5 5312.2 5336.8 5342.3 5240.7 5323.8 5519.4 5526.4 5542.3 5357.6 5375.0 5379.9 5392.6 5424.4 09:54:20 INFO - PROCESS | 8906 | 09:54:20 INFO - PROCESS | 8906 | [#5] yui.html Cycles:180 Average:18048.03 Median:3954.03 stddev:25858.03 (654.0%) stddev-sans-first:25897.55 09:54:20 INFO - PROCESS | 8906 | Values: 645.8 679.2 689.5 722.1 740.5 12257.1 13296.0 13299.1 13452.4 13588.2 13235.3 13327.6 13430.9 13465.5 13534.2 622.8 763.1 772.8 799.2 803.8 793.7 794.1 795.2 798.0 804.1 826.4 827.3 834.3 836.5 839.2 807.7 814.6 815.1 824.4 826.3 596.6 604.6 606.2 608.2 608.5 13570.7 13834.8 13880.2 13941.7 13958.2 13563.3 13626.6 13801.5 13835.1 14031.6 10705.7 10948.2 10954.8 10994.5 11002.6 3383.2 3416.7 3425.5 3445.6 3470.6 65986.7 66582.7 66666.3 66807.3 67275.7 11105.4 11134.6 11233.3 11363.0 11516.3 21213.2 21215.0 21335.0 21774.6 21819.3 6587.3 6597.6 6696.6 6734.6 6911.0 3728.3 3732.2 3819.1 3820.8 3898.5 2818.1 3133.5 3280.9 3295.5 3340.1 539.9 544.0 544.4 544.8 546.9 493.1 498.0 522.6 523.9 529.0 7997.0 8021.2 8235.7 8333.9 8438.3 414.4 437.4 467.7 499.2 504.7 3846.0 3917.5 3990.5 4045.3 4097.7 101545.0 104456.5 105143.0 106242.5 108437.0 53302.2 86877.0 88088.0 88290.6 88880.0 54109.0 76276.2 76677.2 79901.0 81210.0 7447.9 7478.3 7507.2 7596.3 7643.7 33497.2 46183.8 47524.5 48331.3 48559.0 53183.0 54710.7 55708.4 57950.4 61350.7 11283.4 11409.8 11454.3 11455.1 11501.4 12863.7 12978.0 13037.7 13203.6 13258.1 11910.0 11972.9 12148.5 12189.7 12288.4 11671.3 12020.8 12455.9 12501.4 12507.6 11407.3 11876.9 11984.4 12212.9 12230.8 10095.6 10196.7 10306.7 10464.0 10596.4 9666.0 9922.3 10019.6 10113.6 10199.7 09:54:20 INFO - PROCESS | 8906 | -------- Summary: end -------- 09:54:20 INFO - PROCESS | 8906 | 09:54:21 INFO - TEST-INFO | 8906: exit 0 09:54:21 INFO - TEST-OK | dromaeo_css | took 1117601ms 09:54:21 INFO - TEST-START | kraken 09:54:21 INFO - operating with platform_type : linux_ 09:54:21 INFO - Initialising browser for kraken test... 09:54:21 INFO - TEST-INFO | started process 9145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb5RpTz/profile http://localhost:52173/getInfo.html) 09:54:26 INFO - PROCESS | 9145 | __metrics Screen width/height:1600/1200 09:54:26 INFO - PROCESS | 9145 | colorDepth:24 09:54:26 INFO - PROCESS | 9145 | Browser inner width/height: 1024/697 09:54:26 INFO - PROCESS | 9145 | __metrics 09:54:27 ERROR - PROCESS | 9145 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 09:54:28 INFO - TEST-INFO | 9145: exit 0 09:54:28 INFO - Browser initialized. 09:54:28 INFO - Running cycle 1/1 for kraken test... 09:54:28 INFO - TEST-INFO | started process 9264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb5RpTz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:54:40 INFO - PROCESS | 9264 | RSS: Main: 186195968 09:54:40 INFO - PROCESS | 9264 | 09:54:43 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:52173/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52173/tests/kraken/driver.html?testName=audio-beat-detection) 09:54:44 INFO - PROCESS | 9264 | RSS: Main: 190820352 09:54:44 INFO - PROCESS | 9264 | 09:54:46 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:52173/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52173/tests/kraken/driver.html?testName=audio-dft) 09:54:47 INFO - PROCESS | 9264 | RSS: Main: 190353408 09:54:47 INFO - PROCESS | 9264 | 09:54:50 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:52173/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52173/tests/kraken/driver.html?testName=audio-fft) 09:54:51 INFO - PROCESS | 9264 | RSS: Main: 185978880 09:54:51 INFO - PROCESS | 9264 | 09:54:53 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:52173/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52173/tests/kraken/driver.html?testName=audio-oscillator) 09:54:53 INFO - PROCESS | 9264 | RSS: Main: 186449920 09:54:53 INFO - PROCESS | 9264 | 09:54:56 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:52173/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52173/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:54:56 INFO - PROCESS | 9264 | RSS: Main: 187338752 09:54:56 INFO - PROCESS | 9264 | 09:55:00 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:52173/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52173/tests/kraken/driver.html?testName=imaging-darkroom) 09:55:00 INFO - PROCESS | 9264 | RSS: Main: 187195392 09:55:00 INFO - PROCESS | 9264 | 09:55:04 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:52173/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52173/tests/kraken/driver.html?testName=imaging-desaturate) 09:55:04 INFO - PROCESS | 9264 | RSS: Main: 184143872 09:55:04 INFO - PROCESS | 9264 | 09:55:07 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:52173/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52173/tests/kraken/driver.html?testName=json-parse-financial) 09:55:08 INFO - PROCESS | 9264 | RSS: Main: 185450496 09:55:08 INFO - PROCESS | 9264 | 09:55:10 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:52173/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52173/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:55:10 INFO - PROCESS | 9264 | RSS: Main: 186978304 09:55:10 INFO - PROCESS | 9264 | 09:55:12 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:52173/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52173/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:55:13 INFO - PROCESS | 9264 | RSS: Main: 186634240 09:55:13 INFO - PROCESS | 9264 | 09:55:15 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:52173/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52173/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:55:16 INFO - PROCESS | 9264 | RSS: Main: 186597376 09:55:16 INFO - PROCESS | 9264 | 09:55:19 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:52173/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:55:19 INFO - PROCESS | 9264 | RSS: Main: 187129856 09:55:19 INFO - PROCESS | 9264 | 09:55:22 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:52173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:55:23 INFO - PROCESS | 9264 | RSS: Main: 186703872 09:55:23 INFO - PROCESS | 9264 | 09:55:25 INFO - PROCESS | 9264 | Cycle 1(1): loaded http://localhost:52173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52173/tests/kraken/driver.html?testName=ai-astar) 09:55:25 INFO - PROCESS | 9264 | RSS: Main: 187768832 09:55:25 INFO - PROCESS | 9264 | 09:55:25 INFO - PROCESS | 9264 | __start_tp_report 09:55:25 INFO - PROCESS | 9264 | _x_x_mozilla_page_load 09:55:25 INFO - PROCESS | 9264 | _x_x_mozilla_page_load_details 09:55:25 INFO - PROCESS | 9264 | |i|pagename|runs| 09:55:25 INFO - PROCESS | 9264 | |0;ai-astar;114;111;114;116;114;113;116;114;115;115 09:55:25 INFO - PROCESS | 9264 | |1;audio-beat-detection;164;132;156;176;134;165;157;142;197;136 09:55:25 INFO - PROCESS | 9264 | |2;audio-dft;163;165;171;170;165;164;164;163;164;164 09:55:25 INFO - PROCESS | 9264 | |3;audio-fft;79;75;77;175;78;75;75;76;159;77 09:55:25 INFO - PROCESS | 9264 | |4;audio-oscillator;88;87;133;87;87;87;136;86;86;149 09:55:25 INFO - PROCESS | 9264 | |5;imaging-gaussian-blur;117;118;118;117;118;118;117;119;119;118 09:55:25 INFO - PROCESS | 9264 | |6;imaging-darkroom;147;148;150;148;147;148;149;149;148;149 09:55:25 INFO - PROCESS | 9264 | |7;imaging-desaturate;97;96;97;95;96;96;96;96;96;95 09:55:25 INFO - PROCESS | 9264 | |8;json-parse-financial;63;65;63;64;64;67;63;63;62;63 09:55:25 INFO - PROCESS | 9264 | |9;json-stringify-tinderbox;65;64;64;65;65;64;65;66;65;66 09:55:25 INFO - PROCESS | 9264 | |10;stanford-crypto-aes;86;83;85;91;87;87;93;85;113;85 09:55:25 INFO - PROCESS | 9264 | |11;stanford-crypto-ccm;139;137;132;129;140;134;137;135;135;135 09:55:25 INFO - PROCESS | 9264 | |12;stanford-crypto-pbkdf2;173;180;170;177;170;179;173;176;175;175 09:55:25 INFO - PROCESS | 9264 | |13;stanford-crypto-sha256-iterative;71;69;69;73;68;68;68;68;66;66 09:55:25 INFO - PROCESS | 9264 | __end_tp_report 09:55:25 INFO - PROCESS | 9264 | __start_cc_report 09:55:25 INFO - PROCESS | 9264 | _x_x_mozilla_cycle_collect,977 09:55:25 INFO - PROCESS | 9264 | __end_cc_report 09:55:25 INFO - PROCESS | 9264 | __startTimestamp1466182525322__endTimestamp 09:55:25 INFO - PROCESS | 9264 | 09:55:25 INFO - PROCESS | 9264 | ------- Summary: start ------- 09:55:25 INFO - PROCESS | 9264 | Number of tests: 14 09:55:25 INFO - PROCESS | 9264 | 09:55:25 INFO - PROCESS | 9264 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.50 stddev:1.48 (1.3%) stddev-sans-first:1.56 09:55:25 INFO - PROCESS | 9264 | Values: 114.0 111.0 114.0 116.0 114.0 113.0 116.0 114.0 115.0 115.0 09:55:25 INFO - PROCESS | 9264 | 09:55:25 INFO - PROCESS | 9264 | [#1] audio-beat-detection Cycles:10 Average:155.90 Median:160.50 stddev:20.77 (12.9%) stddev-sans-first:21.82 09:55:25 INFO - PROCESS | 9264 | Values: 164.0 132.0 156.0 176.0 134.0 165.0 157.0 142.0 197.0 136.0 09:55:25 INFO - PROCESS | 9264 | 09:55:25 INFO - PROCESS | 9264 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.50 stddev:2.83 (1.7%) stddev-sans-first:2.88 09:55:25 INFO - PROCESS | 9264 | Values: 163.0 165.0 171.0 170.0 165.0 164.0 164.0 163.0 164.0 164.0 09:55:25 INFO - PROCESS | 9264 | 09:55:25 INFO - PROCESS | 9264 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.50 stddev:38.37 (50.2%) stddev-sans-first:40.28 09:55:25 INFO - PROCESS | 9264 | Values: 79.0 75.0 77.0 175.0 78.0 75.0 75.0 76.0 159.0 77.0 09:55:25 INFO - PROCESS | 9264 | 09:55:25 INFO - PROCESS | 9264 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:87.00 stddev:25.67 (29.5%) stddev-sans-first:26.68 09:55:25 INFO - PROCESS | 9264 | Values: 88.0 87.0 133.0 87.0 87.0 87.0 136.0 86.0 86.0 149.0 09:55:25 INFO - PROCESS | 9264 | 09:55:25 INFO - PROCESS | 9264 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 09:55:25 INFO - PROCESS | 9264 | Values: 117.0 118.0 118.0 117.0 118.0 118.0 117.0 119.0 119.0 118.0 09:55:25 INFO - PROCESS | 9264 | 09:55:25 INFO - PROCESS | 9264 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 09:55:25 INFO - PROCESS | 9264 | Values: 147.0 148.0 150.0 148.0 147.0 148.0 149.0 149.0 148.0 149.0 09:55:25 INFO - PROCESS | 9264 | 09:55:25 INFO - PROCESS | 9264 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 09:55:25 INFO - PROCESS | 9264 | Values: 97.0 96.0 97.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 09:55:25 INFO - PROCESS | 9264 | 09:55:25 INFO - PROCESS | 9264 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:63.50 stddev:1.42 (2.2%) stddev-sans-first:1.48 09:55:25 INFO - PROCESS | 9264 | Values: 63.0 65.0 63.0 64.0 64.0 67.0 63.0 63.0 62.0 63.0 09:55:25 INFO - PROCESS | 9264 | 09:55:25 INFO - PROCESS | 9264 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 09:55:25 INFO - PROCESS | 9264 | Values: 65.0 64.0 64.0 65.0 65.0 64.0 65.0 66.0 65.0 66.0 09:55:25 INFO - PROCESS | 9264 | 09:55:25 INFO - PROCESS | 9264 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:86.50 stddev:8.78 (10.2%) stddev-sans-first:9.23 09:55:25 INFO - PROCESS | 9264 | Values: 86.0 83.0 85.0 91.0 87.0 87.0 93.0 85.0 113.0 85.0 09:55:25 INFO - PROCESS | 9264 | 09:55:25 INFO - PROCESS | 9264 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:136.00 stddev:3.23 (2.4%) stddev-sans-first:3.14 09:55:25 INFO - PROCESS | 9264 | Values: 139.0 137.0 132.0 129.0 140.0 134.0 137.0 135.0 135.0 135.0 09:55:25 INFO - PROCESS | 9264 | 09:55:25 INFO - PROCESS | 9264 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:175.50 stddev:3.39 (1.9%) stddev-sans-first:3.54 09:55:25 INFO - PROCESS | 9264 | Values: 173.0 180.0 170.0 177.0 170.0 179.0 173.0 176.0 175.0 175.0 09:55:25 INFO - PROCESS | 9264 | 09:55:25 INFO - PROCESS | 9264 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:2.12 (3.1%) stddev-sans-first:2.06 09:55:25 INFO - PROCESS | 9264 | Values: 71.0 69.0 69.0 73.0 68.0 68.0 68.0 68.0 66.0 66.0 09:55:25 INFO - PROCESS | 9264 | -------- Summary: end -------- 09:55:25 INFO - PROCESS | 9264 | 09:55:26 INFO - TEST-INFO | 9264: exit 0 09:55:26 INFO - TEST-OK | kraken | took 65012ms 09:55:26 INFO - SUITE-END | took 1182s 09:55:26 INFO - Completed test suite (00:19:42) 09:55:26 INFO - javascript benchmark 09:55:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6430.858172599411, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2608.660874086369, 2697.8246413983097, 2707.025470830502, 2711.9864400677993, 2726.6455360803093, 4793.065352256307, 4841.0801947629925, 4866.902661946763, 4937.5309345612195, 4994.250862370646, 4704.952950470494, 4830.613550915927, 4861.562459378655, 4868.29409735589, 4868.878278043051, 4376.343548467739, 4410.338449232609, 4528.9094218115615, 4546.249868771649, 4563.657725670588, 613.727777232953, 4342.652587792984, 4438.4895736990175, 4454.13144436835, 4484.1928452878465, 4478.507364189936, 4493.0, 4503.977480112611, 4510.684252102355, 4526.072155208174, 4503.932441013388, 4511.210538155809, 4517.028838799673, 4541.409616749835, 4555.180067587833, 4372.956270437287, 4376.299792033259, 4388.275934470808, 4397.362382454527, 4456.997175635489, 4763.214069678499, 4860.538248866352, 4868.634852386085, 4899.55903968641, 4907.607391408679, 5193.2989046479, 5226.477352264781, 5245.055889939809, 5259.158534634478, 5324.653897496651, 5271.947280527223, 5308.964751873386, 5314.229436731691, 5324.334458192726, 5354.063038968204, 4882.877928051792, 4927.236278376858, 4933.0, 4933.6299777516115, 4942.28336891156, 5283.920741188886, 5322.0952438085615, 5346.866328341823, 5371.75827087782, 5395.649282796606, 5142.228665700175, 5167.044096842096, 5167.586593072545, 5177.663451875691, 5207.453217412193, 5250.448702886219, 5259.552938000236, 5263.157894736823, 5263.7104959226845, 5309.548688361455, 4993.400791904922, 5065.214891691794, 5115.616328775357, 5190.169572868398, 5197.896042079137, 5112.846614601568, 5185.662931909414, 5201.5838732901275, 5210.088234558937, 5227.947720522822, 4476.888077798081, 4485.0581377911, 4489.281714925596, 4527.501974782771, 4528.456585209796, 3793.943090853639, 3828.789416582115, 3840.615938406137, 3871.4192871069563, 3903.980480097581, 4440.089781594766, 4455.465344158657, 4469.865904022885, 4500.212462818994, 4574.016586433932, 5229.581633469314, 5229.738513074407, 5254.789808407697, 5272.92090618641, 5275.947240527546, 4402.603765661106, 4476.597106260452, 4499.6400287976885, 4515.63874890008, 4523.977380113144, 4726.976365118152, 4756.453007904135, 4769.2130798417875, 4776.355192049098, 4806.375171227718, 4915.21356582945, 4951.1088004158155, 4966.503349665005, 4966.776495057803, 5001.549860512571, 5091.898162036665, 5135.717535535432, 5151.871203219799, 5157.07172708901, 5224.660397074178, 4885.316055752127, 4888.462269150462, 4903.0, 4918.926216106833, 4932.087563800565, 5147.047796157723, 5149.201873709581, 5156.5616922562, 5201.92197117036, 5216.817411390583, 5078.923816142835, 5213.400458947118, 5230.849213173095, 5267.2889159962915, 5278.5249327560705, 5128.12821820284, 5137.049645815536, 5137.92293115611, 5150.072986862401, 5168.0, 5105.387353517602, 5113.821016264413, 5125.69294829816, 5129.051125541787, 5180.533751962342, 4907.55831975124, 4948.8762780930765, 5026.421961474331, 5051.217061355495, 5052.115879721107, 5132.5124113209185, 5156.355455568054, 5160.638755287094, 5163.432022477449, 5174.379074511083, 5059.342285502861, 5066.113430149635, 5066.468020857904, 5072.391313042459, 5098.439171691037], "value": 4769.77050163303, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.5771265575161, 583.2650859916505, 587.0900104837503, 599.5623195067601, 611.1352436302632, 34762.0, 38162.8091859541, 38169.23661526768, 38239.23521529571, 38337.04157396063, 38483.23033539327, 39263.80368098155, 39269.803650981776, 39297.607023929755, 39334.21331573374, 7701.4608977371745, 7809.492382995116, 7844.372450203999, 7846.293833554979, 7874.960625196894, 7789.376849852027, 7806.726764563241, 7852.685892564291, 7876.369890408753, 7888.487248328869, 7912.129665736765, 7917.604119794016, 7935.960320198391, 7937.682492700285, 7956.880646790303, 7857.096433910087, 7866.292033716993, 7889.408294377945, 7904.0, 7908.683652653945, 7756.612169391507, 7818.4136189785995, 7823.8435231295625, 7871.8032049198655, 7874.803129921741, 36370.0, 36661.633383666085, 36676.44985325222, 36813.0, 36933.81533092344, 3202.503611940153, 3407.148212946763, 3534.2401383702627, 3675.099600597844, 3773.7735735855663, 28863.0, 28929.710702892913, 29288.560671589945, 29508.40983180346, 29774.55338169929, 3489.319582681378, 3491.546099007113, 3540.8583656653705, 3619.2580520993133, 3671.467637192619, 251464.0, 252660.0, 252798.0, 253715.0, 253839.73080134665, 30749.231269218002, 31551.36897262088, 31691.84154079215, 50986.0, 51734.48265517372, 33339.66660333414, 33350.49974250388, 33744.83127584396, 33761.32477350439, 33776.49335259973, 12491.687707807196, 12661.0, 12692.746145077046, 12709.872901271054, 12710.364481775874, 10470.581176752998, 10595.417252051211, 10599.523021464052, 10615.363078215332, 10672.039516443558, 7775.688972441039, 7931.920680793233, 7943.602819859099, 7966.243206895336, 7982.042154941328, 3165.5409965554863, 3178.507331363642, 3194.552762613236, 3202.4715921873094, 3210.967890321114, 858.4420126917554, 968.5883499512679, 984.3749219245688, 1028.5114570579065, 1029.3669393323053, 28207.43585128286, 28233.576496352573, 28266.717332826818, 28601.0, 28764.280892977844, 972.1445128287204, 979.480875136179, 992.0327680511443, 1028.3624153025023, 1038.5326603028516, 14881.0, 14930.25348732559, 15077.321520531603, 15106.320215590325, 15280.617984550476, 371144.0, 373112.0, 374489.0, 375144.0, 375220.0, 48147.518524815, 48486.27270590944, 48623.513764862604, 48624.75687621539, 48654.75672621614, 1171.472837223236, 1188.6849984754047, 1203.620859429277, 1213.5206593395735, 1219.2379762648345, 26815.865920670272, 27425.0, 27448.862755686092, 27886.0, 28287.0, 42203.0, 42314.36528452014, 42607.57392426036, 42669.57330426656, 42761.786191068844, 323509.0, 324816.87957801245, 325804.0, 325810.0, 326160.0, 24984.125555605468, 25047.0, 25151.49697006013, 25236.74763252344, 25388.238352849443, 41196.38205426861, 41515.0, 41856.58143418527, 42104.78947605365, 42278.788606056776, 35718.46422303616, 35907.0, 36165.457518136725, 36301.0, 36736.0, 36203.29566008164, 36663.816680916425, 36895.44656830096, 37083.6291637091, 37477.0, 32574.34851303008, 35820.820895895355, 36091.0, 36412.45381319335, 39912.60087399089, 31364.37271254608, 32753.50869736908, 32851.178720532174, 32945.835270823496, 33124.834375827966, 25319.873400632878, 25472.108476203244, 25534.872325638255, 25569.23292301234, 25675.871620642523], "value": 16427.214488064354, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.64362924334137, 365.53029357275886, 369.7929159670585, 374.52996489405825, 376.77770115631773, 16642.334306627734, 17054.573635659115, 17622.911885440586, 17869.910650446745, 17876.82123178768, 16163.353465861352, 16609.501714948572, 17278.740818887694, 17293.740593891103, 17320.740188897144, 4907.975460122694, 5071.112555302826, 5125.282460455539, 5129.333186685725, 5130.3074084998425, 3691.2432951245064, 5050.292958985727, 5590.440955904397, 6017.217761690974, 6018.127371531125, 5972.19375384324, 6005.279366476029, 6027.849303767419, 6037.6075555089, 6074.453299203071, 5888.676122813244, 6003.6697981611, 6059.424354686298, 6066.939330606704, 6077.602151505156, 5280.630355875091, 5290.55030322423, 5302.2046692996355, 5307.416184219733, 5365.436629153922, 21241.25655602062, 21299.949745493377, 21423.67864482034, 21521.677174842232, 21968.121275149133, 1882.4634979031048, 1953.3846838245906, 1962.4014675523958, 2032.573159636478, 2132.4455641533314, 12939.870601294055, 13149.737005259936, 13652.180869147884, 13697.931510342483, 13824.516141934984, 1771.68109740248, 1772.344232633921, 1785.544686105048, 1792.0, 1796.4161647464625, 44098.77950610258, 67650.0, 67904.3209567903, 68003.65998170027, 68265.65867170681, 9603.279754018477, 9946.502674866228, 9992.65025724096, 10143.898561014443, 10670.51982660782, 13415.932920335532, 13429.731405372033, 13535.32323383827, 13633.0, 13709.17744935307, 6901.344372284625, 7054.75308364215, 7145.321194486515, 7163.785086447415, 7256.4194864411775, 6849.212340580797, 6895.448364130857, 6924.342187492281, 7118.113699869538, 7131.607761573059, 6061.272647282354, 6517.576357536745, 6549.279579246279, 6634.303398143222, 6778.423833974168, 1599.224376177553, 1715.6054107555333, 1756.8770186087106, 1781.6080462298273, 1799.8290162434548, 799.5922079739258, 830.5556527257888, 846.3187134356901, 935.3686261773275, 968.1238479176357, 15601.609959751097, 16803.495895123167, 17125.14374281281, 17169.399071032454, 17627.0, 816.542736067804, 862.3187681731488, 876.2157868707599, 908.246155690775, 910.7814124610046, 9129.81740365189, 9539.0, 9544.52277386128, 9548.236141108695, 9794.951025244829, 295947.0, 300114.0, 426479.0, 431987.0, 435076.0, 80009.59995199987, 82507.17492825114, 84298.57850710707, 84948.0, 85256.57371713102, 879.5470332778624, 903.503073309677, 933.6452148183647, 933.8552524358736, 949.8575213717997, 15842.494962978499, 15949.681006379575, 16056.19719014068, 16126.193690315202, 16518.83481165173, 26104.8694756525, 26375.34061648474, 37260.254794903405, 37566.0, 38575.42136868005, 52881.0, 53484.197737033195, 53552.73223633857, 53607.46392536024, 53877.46122538725, 7534.133574638987, 7605.087389513294, 7643.426742994409, 7748.496347737379, 7771.33943614799, 11255.943720281346, 11972.982296504895, 11997.160198786001, 12026.639200823989, 12230.266184028631, 4992.675476094042, 7958.761237162895, 10392.636257730943, 10679.46602669848, 10785.245032847939, 10217.182625389802, 10243.334183278062, 10254.846177307496, 10324.380537167794, 10643.361398316125, 9955.352902061342, 10160.390376577428, 10368.911264317137, 10616.681499555025, 10957.83563246568, 7426.962865185639, 7455.813604659927, 7503.887441688488, 7613.581253031137, 7739.264769846855, 9872.506374681094, 9935.20518358544, 10124.190064794651, 10426.739331516772, 10495.632652857113], "value": 8405.31662579289, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.356680576726, 1404.262762049924, 1482.733108040553, 1636.582671418788, 1682.2429906542052, 6841.555298905568, 7412.184659687437, 7590.962045189766, 7949.364050875931, 8068.435209535335, 7683.270089341504, 7715.459917805756, 7835.764927052198, 7872.448928575002, 7888.250616191467, 2199.164317559329, 2207.75714671386, 2231.129859354853, 2235.865848049114, 2246.3934737620834, 2158.7625361210253, 2214.081156320125, 2235.653473711577, 2250.4261413339577, 2258.8080013198896, 2217.756046834847, 2222.4777177363308, 2227.365200917731, 2228.3871935217862, 2229.1194977983687, 2118.078635793427, 2121.9363419097454, 2125.234915430444, 2131.7548481924623, 2134.2423439678846, 2122.1193204819983, 2162.4485756132244, 2173.7065496157975, 2187.0377034105104, 2187.8359123065834, 7803.531788092732, 7853.528788272665, 7900.091489478726, 7916.841663166762, 8010.158933311976, 4515.729056256635, 4602.217623004064, 4609.423822022247, 4610.76946152691, 4635.46692130406, 2807.5507918732906, 2901.5937768712397, 2935.1194641607644, 2938.9853050734823, 2965.0956458280216, 864.2912811494577, 889.8976617688984, 895.5208963204655, 900.3652425040331, 926.4487629860222, 10387.169026477864, 10506.212034097472, 10572.947135264274, 10577.31247468912, 10671.306365086244, 4140.130572579792, 4191.517975432804, 4266.658667306608, 4275.337322714984, 4302.634276086567, 8950.731478055668, 9006.234470069987, 9031.593578288992, 9078.86381704275, 9080.22818060459, 4392.472903251631, 4440.844570440019, 4447.066116115588, 4448.7108337957925, 4480.663950203748, 3626.5285512883156, 4079.265732168179, 4090.877273681794, 4093.5701751315682, 4259.233337999128, 3653.762505437138, 3680.8895733128047, 3747.4191500317493, 3793.241351729665, 3847.3844184930276, 1180.6753142885602, 1185.7569198314325, 1186.7507823357018, 1192.5170306026073, 1196.6469891382062, 801.6753214947955, 817.4196320612432, 820.5856042698518, 824.2220353237944, 826.0871736730946, 4913.803447862117, 5061.4179369373, 5083.898322033612, 5254.448282930313, 5281.075811733008, 394.3847597747523, 410.9157622687402, 410.9773962432035, 412.44320167773265, 412.53177643374386, 3787.2046870157023, 3940.704447166474, 3946.6645335146836, 4008.398740188995, 4017.9397309040387, 9567.952160239154, 9803.558839852223, 9840.507974601242, 9873.308868379145, 9910.45492497905, 9245.445273283625, 9560.426374417557, 9593.904060959301, 9672.0, 9822.410655360702, 7275.636218189069, 7336.559806411632, 7339.192688804227, 7418.146913104954, 7462.02993610838, 5060.291559181644, 5218.464724094286, 5240.187770895517, 5328.387235467971, 5498.642588231752, 8842.0, 8909.420887642282, 9128.49793261377, 9201.447913125234, 9208.539573021457, 9143.679971200976, 9230.815383692423, 9282.62869485213, 9301.813963720822, 9319.114684105, 6246.531510136667, 6535.3137920517665, 6568.310327415744, 6673.866522669617, 6687.732490700318, 7315.707371705073, 7338.119425668954, 7355.5586664800285, 7413.147488038729, 7444.404447644284, 6529.347065293433, 6796.116504854337, 6848.726050958106, 6885.345892140439, 6910.0, 6438.420542151041, 6503.6097834130105, 6574.211094668671, 6636.800895973129, 6671.0, 5808.796692115925, 5816.040353341651, 5818.970905145447, 5820.097884827858, 5860.970695146668, 4227.97886010568, 4246.808893599858, 4372.256716358163, 4406.559344065696, 4480.39514665516, 4441.356003379557, 4472.9552704472535, 4512.210363186495, 4597.7011494252765, 4656.138614356355], "value": 4044.2265874951463, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.54043462415933, 298.2662649881292, 299.83658905896283, 301.05768943207755, 304.7227023408698, 5163.870903227421, 5199.922001169981, 5213.635045546814, 5233.816816411421, 5246.816361427342, 5062.594992400608, 5107.7701503432345, 5116.590672746181, 5122.974385128078, 5156.948430515694, 3767.3595488766973, 3881.0, 3975.6223158799867, 3976.6023397660147, 3997.2405243003736, 3997.4203740457615, 4004.679625629957, 4029.07331313798, 4029.4761680981433, 4054.1891621675636, 3982.6017398260087, 3994.820233089518, 4002.8598999034893, 4022.4368588397647, 4028.738132021409, 3709.7774133552075, 3942.664873485757, 3955.20895820837, 3989.2221016901717, 4028.1742242840146, 3411.2665776858094, 3421.6920477157178, 3428.8114153721535, 3438.48422736589, 3440.7419443541585, 4911.361523002022, 4951.876203094916, 4967.82612608557, 5003.399592048978, 5025.899482010339, 4176.415301857743, 4503.549645035503, 4518.096380723836, 4527.479339875924, 4528.50186479487, 5256.92114618281, 5297.602679798992, 5333.839984800462, 5368.70472124033, 5383.73081345935, 3692.095436618019, 3695.447911877018, 3703.666669999713, 3711.1464363196615, 3726.1988672435286, 5425.9186112208345, 5654.331972068249, 5654.6324488908085, 5685.772569097231, 5695.45893140151, 3785.337565926007, 3795.905102372463, 3823.2544653792243, 3824.541055073409, 3832.7317087804145, 3902.1415288636454, 3920.7843568604, 3921.941170882439, 3923.509561304837, 3927.3323534999117, 4510.345999830072, 4514.864554063383, 4542.9772851136195, 4546.204414227497, 4551.431071116111, 5295.285136506599, 5315.335583052119, 5405.702686352289, 5427.565794736412, 5459.481349271813, 1311.9278439685909, 1332.8933685305153, 1335.7528857161456, 1340.1088276296348, 1342.838859336886, 835.5362773660677, 847.6099197316406, 851.7785375802335, 857.2070834478083, 869.7173418638968, 4545.886352841206, 4604.595598342537, 4614.10025045113, 4633.2818413146015, 4658.254679251371, 5418.539424148913, 5450.618456707993, 5459.645123066988, 5470.370907345706, 5472.480114389126, 4486.349479325545, 4573.108243892476, 4591.242444996605, 4606.700564463366, 4645.117427688729, 2906.1717410537894, 2947.410517896429, 2949.985250073736, 2958.4083183363414, 2960.555916612482, 5101.34206382927, 5116.334876466036, 5134.563562097189, 5135.460776618401, 5140.948590514122, 5438.096666166889, 5589.888202235932, 5590.776368945278, 5599.356074051536, 5600.467955544217, 5132.563732082815, 5143.408508021551, 5156.1750119980625, 5156.871078222925, 5162.5286793264495, 5451.836444906659, 5453.464139175302, 5493.395726470005, 5497.36780270274, 5512.932650256154, 5067.822626208213, 5357.116075847442, 5368.2752828367675, 5379.623426360117, 5384.542313903362, 5078.542931136216, 5117.8720531987, 5121.0, 5130.461301563282, 5135.948640513547, 3749.6625303722794, 3794.6774524164653, 3871.438641397038, 3878.069263376826, 3887.3197190492115, 5305.1776974569, 5431.131019036935, 5450.563954883521, 5453.400125986059, 5506.834794956158, 5323.547498462674, 5332.78668853257, 5340.652857564246, 5348.919766203432, 5381.461853814587, 5068.746562671926, 5302.8939421212135, 5304.761285742228, 5327.696827966685, 5339.3058902342445, 5294.841154765363, 5308.469153084815, 5312.150055991177, 5336.813211537577, 5342.332208473941, 5240.71176085319, 5323.787048518171, 5519.420460851713, 5526.41972592888, 5542.279503664659, 5357.598180136583, 5374.973125134506, 5379.946200537945, 5392.568594512508, 5424.376196737426], "value": 3999.3907837019824, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.777206863632, 679.2392520377178, 689.5207830557764, 722.0577146823395, 740.4853626729418, 12257.14200006, 13296.0, 13299.135556188841, 13452.394642241099, 13588.184708917448, 13235.33823308833, 13327.60017199483, 13430.865691343084, 13465.46138154475, 13534.187948723058, 622.7695752571555, 763.076677220561, 772.7758949904521, 799.188823344306, 803.8432505661399, 793.6666600027974, 794.0590400375545, 795.1571334385541, 797.9680812767482, 804.0512195609178, 826.446280991737, 827.3050637464529, 834.3367023216557, 836.5440834745048, 839.1734141870284, 807.6728924785472, 814.6293436486385, 815.0708192660372, 824.4146655874276, 826.277007618334, 596.6092209602717, 604.607005446459, 606.2240332374568, 608.1728848765675, 608.4706305514231, 13570.728585428236, 13834.792478112837, 13880.236586987712, 13941.721165576631, 13958.232297223649, 13563.254021028839, 13626.591202263948, 13801.51694690691, 13835.100718453268, 14031.649208769863, 10705.678829635046, 10948.233623646347, 10954.835677464844, 10994.505247263813, 11002.614908478245, 3383.188034871613, 3416.6754158354915, 3425.469052296898, 3445.638207988175, 3470.5661792275964, 65986.67006664936, 66582.66708666425, 66666.33333666698, 66807.33192668059, 67275.66362168206, 11105.38920359388, 11134.554617815358, 11233.269837460539, 11363.0, 11516.30902145874, 21213.15147394087, 21215.0, 21335.0, 21774.564508709736, 21819.345419637437, 6587.308332625101, 6597.571157874723, 6696.5647232929705, 6734.629595372204, 6911.03245545624, 3728.3102626014274, 3732.197577520846, 3819.0834199792407, 3820.8089595520114, 3898.5126859142606, 2818.126380821952, 3133.4516459619476, 3280.868765249411, 3295.4562497188176, 3340.1148695595684, 539.8893226888479, 543.9700816455054, 544.4174733035693, 544.7957016118955, 546.8632841789553, 493.1370102320938, 497.96737866393835, 522.5532169994676, 523.8926020165857, 528.9973550132224, 7997.0, 8021.2379823916635, 8235.711750088718, 8333.916660833434, 8438.324934005388, 414.41774307098575, 437.4094971788061, 467.71235690051054, 499.21872269897494, 504.7198804663447, 3845.9807700961874, 3917.5298964124486, 3990.521137463523, 4045.2516284487465, 4097.692673049533, 101545.0, 104456.47771761092, 105143.0, 106242.46878765557, 108437.0, 53302.173544741134, 86877.0, 88088.0, 88290.55854720814, 88880.0, 54109.0, 76276.23723762692, 76677.233227667, 79901.0, 81210.0, 7447.88828167567, 7478.2895624915545, 7507.211742767149, 7596.278353556403, 7643.694252230071, 33497.16257093592, 46183.76908115438, 47524.52475475201, 48331.275030875266, 48559.0, 53183.0, 54710.72644636752, 55708.442915570326, 57950.420495794504, 61350.69324653348, 11283.435828208721, 11409.771804563696, 11454.312741235553, 11455.109906865275, 11501.367424791382, 12863.742725145257, 12978.0, 13037.674058148243, 13203.603891883258, 13258.138221015603, 11910.0, 11972.880271197177, 12148.514059437524, 12189.69525761863, 12288.385580721108, 11671.299722016705, 12020.75958480843, 12455.875441245835, 12501.374931253218, 12507.624771256877, 11407.315561066363, 11876.940615296868, 11984.40077996114, 12212.877871221173, 12230.755384892074, 10095.596176152872, 10196.745081373025, 10306.690799276033, 10464.00591943764, 10596.417197054236, 9665.951670241886, 9922.255830812574, 10019.649312274036, 10113.59545618167, 10199.7450063749], "value": 6639.317594558602, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1591.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 114.0, 116.0, 114.0, 113.0, 116.0, 114.0, 115.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 132.0, 156.0, 176.0, 134.0, 165.0, 157.0, 142.0, 197.0, 136.0], "value": 155.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 171.0, 170.0, 165.0, 164.0, 164.0, 163.0, 164.0, 164.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 77.0, 175.0, 78.0, 75.0, 75.0, 76.0, 159.0, 77.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 133.0, 87.0, 87.0, 87.0, 136.0, 86.0, 86.0, 149.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 119.0, 119.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 150.0, 148.0, 147.0, 148.0, 149.0, 149.0, 148.0, 149.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 63.0, 64.0, 64.0, 67.0, 63.0, 63.0, 62.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 66.0, 65.0, 66.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 85.0, 91.0, 87.0, 87.0, 93.0, 85.0, 113.0, 85.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 132.0, 129.0, 140.0, 134.0, 137.0, 135.0, 135.0, 135.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 180.0, 170.0, 177.0, 170.0, 179.0, 173.0, 176.0, 175.0, 175.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 69.0, 73.0, 68.0, 68.0, 68.0, 68.0, 66.0, 66.0], "value": 68.6, "unit": "score"}]}]} 09:55:27 INFO - Return code: 0 09:55:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:55:27 ERROR - # TBPL SUCCESS # 09:55:27 INFO - Running post-action listener: _resource_record_post_action 09:55:27 INFO - ##### 09:55:27 INFO - ##### Finished run-tests step (success) 09:55:27 INFO - ##### 09:55:27 INFO - Running post-run listener: _resource_record_post_run 09:55:27 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549859328; Read time: 8; Write time: 521624 09:55:27 INFO - TinderboxPrint: CPU usage
13.4% 09:55:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:55:27 INFO - TinderboxPrint: I/O write bytes / time
549,859,328 / 521,624 09:55:27 INFO - TinderboxPrint: CPU idle
8,284.9 (86.5%) 09:55:27 INFO - TinderboxPrint: CPU user
1,231.9 (12.9%) 09:55:27 INFO - TinderboxPrint: Swap in / out
0 / 0 09:55:27 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252121088; Read time: 0; Write time: 253796 09:55:27 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297738240; Read time: 8; Write time: 267828 09:55:27 INFO - Running post-run listener: _upload_blobber_files 09:55:27 INFO - Blob upload gear active. 09:55:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:55:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:55:27 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'] 09:55:27 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 09:55:28 INFO - (blobuploader) - INFO - Open directory for files ... 09:55:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:55:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:55:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:55:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:55:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:55:29 INFO - (blobuploader) - INFO - Done attempting. 09:55:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:55:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:55:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:55:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:55:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:55:29 INFO - (blobuploader) - INFO - Done attempting. 09:55:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:55:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:55:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:55:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:55:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:55:33 INFO - (blobuploader) - INFO - Done attempting. 09:55:33 INFO - (blobuploader) - INFO - Iteration through files over. 09:55:33 INFO - Return code: 0 09:55:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:55:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:55:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3288315dbfd91bf063f7f2ea587af2b00aff83ae1c7cff7362f92a14be03346ce554f8290b5fa2bce4db1e2716efcd80178f52c974a597eafbd7b52ec17b42e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6625cd562a958b80a5cc50a4daf15e0a79829d2012cde7d85f95f748ceaeed4c3155d52f5c40897f73887ed151493347fce87508e2c008e00eb62673bfaeb283", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40f71ef5799c982bdcbcc11fb6001c5fd65d07a6feebe52f5bd6a865bfe46a585e0a666a2b6ec281c462f1f70700cc9123b4e837da404a5c1684739971f03125"} 09:55:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:55:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:55:33 INFO - Contents: 09:55:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3288315dbfd91bf063f7f2ea587af2b00aff83ae1c7cff7362f92a14be03346ce554f8290b5fa2bce4db1e2716efcd80178f52c974a597eafbd7b52ec17b42e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6625cd562a958b80a5cc50a4daf15e0a79829d2012cde7d85f95f748ceaeed4c3155d52f5c40897f73887ed151493347fce87508e2c008e00eb62673bfaeb283", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40f71ef5799c982bdcbcc11fb6001c5fd65d07a6feebe52f5bd6a865bfe46a585e0a666a2b6ec281c462f1f70700cc9123b4e837da404a5c1684739971f03125"} 09:55:33 INFO - Running post-run listener: copy_logs_to_upload_dir 09:55:33 INFO - Copying logs to upload dir... 09:55:33 INFO - mkdir: /builds/slave/test/build/upload/logs 09:55:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.454865 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-17 09:55:32.541961) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 09:55:32.545707) ========= 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=c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462 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/3288315dbfd91bf063f7f2ea587af2b00aff83ae1c7cff7362f92a14be03346ce554f8290b5fa2bce4db1e2716efcd80178f52c974a597eafbd7b52ec17b42e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6625cd562a958b80a5cc50a4daf15e0a79829d2012cde7d85f95f748ceaeed4c3155d52f5c40897f73887ed151493347fce87508e2c008e00eb62673bfaeb283", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40f71ef5799c982bdcbcc11fb6001c5fd65d07a6feebe52f5bd6a865bfe46a585e0a666a2b6ec281c462f1f70700cc9123b4e837da404a5c1684739971f03125"} build_url:https://queue.taskcluster.net/v1/task/C5pWj35TQ4C7IrktpKaYlQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/C5pWj35TQ4C7IrktpKaYlQ/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/3288315dbfd91bf063f7f2ea587af2b00aff83ae1c7cff7362f92a14be03346ce554f8290b5fa2bce4db1e2716efcd80178f52c974a597eafbd7b52ec17b42e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6625cd562a958b80a5cc50a4daf15e0a79829d2012cde7d85f95f748ceaeed4c3155d52f5c40897f73887ed151493347fce87508e2c008e00eb62673bfaeb283", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/40f71ef5799c982bdcbcc11fb6001c5fd65d07a6feebe52f5bd6a865bfe46a585e0a666a2b6ec281c462f1f70700cc9123b4e837da404a5c1684739971f03125"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 09:55:32.571577) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:55:32.571914) ========= 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=c6927cf182745ad25b1d38b9000001fe-1466181189.838388-393558462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:55:32.655429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 09:55:32.655787) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 09:55:32.656137) ========= ========= Total master_lag: 0.17 =========