builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-057 starttime: 1457725813.78 results: success (0) buildid: 20160311110827 builduid: 732e9e8378524fbab7bf0f54fc9c5a6b revision: 5105e61dec9f879b87b374c4dd11981c9c18b7f3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:13.779876) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:13.780311) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:13.780608) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005940 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:13.807980) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:13.808331) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:14.079883) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:14.080257) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:14.129482) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:14.132867) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:14.133265) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:14.133551) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-11 11:50:14-- 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% 226M=0s 2016-03-11 11:50:14 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123884 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:14.270476) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:14.271958) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022529 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:14.322220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:14.322963) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5105e61dec9f879b87b374c4dd11981c9c18b7f3 --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 5105e61dec9f879b87b374c4dd11981c9c18b7f3 --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=934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-11 11:50:14,822 truncating revision to first 12 chars 2016-03-11 11:50:14,822 Setting DEBUG logging. 2016-03-11 11:50:14,822 attempt 1/10 2016-03-11 11:50:14,822 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5105e61dec9f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 11:50:15,084 unpacking tar archive at: fx-team-5105e61dec9f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.573551 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:14.910649) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:14.911004) ========= echo 5105e61dec9f879b87b374c4dd11981c9c18b7f3 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5105e61dec9f879b87b374c4dd11981c9c18b7f3'] 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=934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5105e61dec9f879b87b374c4dd11981c9c18b7f3 program finished with exit code 0 elapsedTime=0.004296 script_repo_revision: '5105e61dec9f879b87b374c4dd11981c9c18b7f3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:14.961973) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:14.962587) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 11:50:14.973442) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-11 11:50:14.973818) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:50:15 INFO - MultiFileLogger online at 20160311 11:50:15 in /builds/slave/test 11:50:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 11:50:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:50:15 INFO - {'append_to_log': False, 11:50:15 INFO - 'base_work_dir': '/builds/slave/test', 11:50:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:50:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:50:15 INFO - 'branch': 'Fx-Team-Non-PGO', 11:50:15 INFO - 'buildbot_json_path': 'buildprops.json', 11:50:15 INFO - 'config_files': ('talos/linux_config.py',), 11:50:15 INFO - 'default_actions': ('clobber', 11:50:15 INFO - 'read-buildbot-config', 11:50:15 INFO - 'download-and-extract', 11:50:15 INFO - 'populate-webroot', 11:50:15 INFO - 'create-virtualenv', 11:50:15 INFO - 'install', 11:50:15 INFO - 'run-tests'), 11:50:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:50:15 INFO - 'download_minidump_stackwalk': True, 11:50:15 INFO - 'download_symbols': 'ondemand', 11:50:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:50:15 INFO - 'tooltool.py': '/tools/tooltool.py', 11:50:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:50:15 INFO - '/tools/misc-python/virtualenv.py')}, 11:50:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:50:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:50:15 INFO - 'installer_path': 'installer.exe', 11:50:15 INFO - 'log_level': 'info', 11:50:15 INFO - 'log_name': 'talos', 11:50:15 INFO - 'log_to_console': True, 11:50:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:50:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:50:15 INFO - 'opt_config_files': (), 11:50:15 INFO - 'pip_index': False, 11:50:15 INFO - 'sps_profile': False, 11:50:15 INFO - 'sps_profile_interval': 0, 11:50:15 INFO - 'suite': 'dromaeojs', 11:50:15 INFO - 'system_bits': '32', 11:50:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:50:15 INFO - 'title': 'talos-linux64-ix-057', 11:50:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:50:15 INFO - 'use_talos_json': True, 11:50:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:50:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:50:15 INFO - 'work_dir': 'build'} 11:50:15 INFO - ##### 11:50:15 INFO - ##### Running clobber step. 11:50:15 INFO - ##### 11:50:15 INFO - Running pre-action listener: _resource_record_pre_action 11:50:15 INFO - Running main action method: clobber 11:50:15 INFO - rmtree: /builds/slave/test/build 11:50:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:50:16 INFO - Running post-action listener: _resource_record_post_action 11:50:16 INFO - ##### 11:50:16 INFO - ##### Running read-buildbot-config step. 11:50:16 INFO - ##### 11:50:16 INFO - Running pre-action listener: _resource_record_pre_action 11:50:16 INFO - Running main action method: read_buildbot_config 11:50:16 INFO - Using buildbot properties: 11:50:16 INFO - { 11:50:16 INFO - "project": "", 11:50:16 INFO - "product": "firefox", 11:50:16 INFO - "script_repo_revision": "production", 11:50:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:50:16 INFO - "repository": "", 11:50:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:50:16 INFO - "buildid": "20160311110827", 11:50:16 INFO - "pgo_build": "False", 11:50:16 INFO - "basedir": "/builds/slave/test", 11:50:16 INFO - "buildnumber": 2629, 11:50:16 INFO - "slavename": "talos-linux64-ix-057", 11:50:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:50:16 INFO - "platform": "ubuntu64_hw", 11:50:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:50:16 INFO - "branch": "fx-team", 11:50:16 INFO - "repo_path": "integration/fx-team", 11:50:16 INFO - "revision": "5105e61dec9f879b87b374c4dd11981c9c18b7f3", 11:50:16 INFO - "stage_platform": "linux64", 11:50:16 INFO - "builduid": "732e9e8378524fbab7bf0f54fc9c5a6b", 11:50:16 INFO - "slavebuilddir": "test" 11:50:16 INFO - } 11:50:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:50:16 INFO - Running post-action listener: _resource_record_post_action 11:50:16 INFO - ##### 11:50:16 INFO - ##### Running download-and-extract step. 11:50:16 INFO - ##### 11:50:16 INFO - Running pre-action listener: _resource_record_pre_action 11:50:16 INFO - Running main action method: download_and_extract 11:50:16 INFO - mkdir: /builds/slave/test/build/tests 11:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:16 INFO - https://queue.taskcluster.net/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:50:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:50:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:50:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:50:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:50:16 INFO - Downloaded 1361 bytes. 11:50:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:50:16 INFO - Using the following test package requirements: 11:50:16 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:50:16 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:50:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:50:16 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:50:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:50:16 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:50:16 INFO - u'jsshell-linux-x86_64.zip'], 11:50:16 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:50:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:50:16 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:50:16 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:50:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:50:16 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:50:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:50:16 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:50:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:50:16 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:50:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:50:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:16 INFO - https://queue.taskcluster.net/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:50:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:50:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:50:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:50:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:50:17 INFO - Downloaded 22090782 bytes. 11:50:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:50:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:50:19 INFO - Return code: 0 11:50:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:50: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')]} 11:50:19 INFO - https://queue.taskcluster.net/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:50:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:50:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:50:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:50:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:50:20 INFO - Downloaded 22090782 bytes. 11:50:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:50:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:50:21 INFO - Return code: 0 11:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:21 INFO - https://queue.taskcluster.net/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:50:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:50:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:50:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:50:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:50:22 INFO - Downloaded 10845263 bytes. 11:50:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:50:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:50:22 INFO - Return code: 0 11:50:22 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')]} 11:50:22 INFO - https://queue.taskcluster.net/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:50:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:50:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:50:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:50:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:50:24 INFO - Downloaded 54465086 bytes. 11:50:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:50:24 INFO - mkdir: /builds/slave/test/properties 11:50:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:50:24 INFO - Writing to file /builds/slave/test/properties/build_url 11:50:24 INFO - Contents: 11:50:24 INFO - build_url:https://queue.taskcluster.net/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:50:24 INFO - Running post-action listener: _resource_record_post_action 11:50:24 INFO - Running post-action listener: set_extra_try_arguments 11:50:24 INFO - ##### 11:50:24 INFO - ##### Running populate-webroot step. 11:50:24 INFO - ##### 11:50:24 INFO - Running pre-action listener: _resource_record_pre_action 11:50:24 INFO - Running main action method: populate_webroot 11:50:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:50:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:50:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:50:24 INFO - '--tppagecycles', 11:50:24 INFO - '7'], 11:50:24 INFO - 'tests': ['tsvgm']}}, 11:50:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:50:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:50:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:50:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:50:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:50:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:50:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:50:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:50:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:50:24 INFO - 'talos_options': ['--e10s'], 11:50:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:50:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:50:24 INFO - 'tests': ['damp', 'tps']}, 11:50:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:50:24 INFO - 'talos_options': ['--e10s'], 11:50:24 INFO - 'tests': ['damp', 'tps']}, 11:50:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:50:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:50:24 INFO - 'other': {'tests': ['a11yr', 11:50:24 INFO - 'ts_paint', 11:50:24 INFO - 'tpaint', 11:50:24 INFO - 'sessionrestore', 11:50:24 INFO - 'sessionrestore_no_auto_restore', 11:50:24 INFO - 'tabpaint']}, 11:50:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:50:24 INFO - 'tests': ['a11yr', 11:50:24 INFO - 'ts_paint', 11:50:24 INFO - 'tpaint', 11:50:24 INFO - 'sessionrestore', 11:50:24 INFO - 'sessionrestore_no_auto_restore', 11:50:24 INFO - 'tabpaint']}, 11:50:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:50:24 INFO - 'tests': ['a11yr', 11:50:24 INFO - 'ts_paint', 11:50:24 INFO - 'tpaint', 11:50:24 INFO - 'sessionrestore', 11:50:24 INFO - 'sessionrestore_no_auto_restore', 11:50:24 INFO - 'tabpaint']}, 11:50:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:50:24 INFO - 'tests': ['a11yr', 11:50:24 INFO - 'ts_paint', 11:50:24 INFO - 'tpaint', 11:50:24 INFO - 'sessionrestore', 11:50:24 INFO - 'sessionrestore_no_auto_restore', 11:50:24 INFO - 'tabpaint']}, 11:50:24 INFO - 'other_l64': {'tests': ['a11yr', 11:50:24 INFO - 'ts_paint', 11:50:24 INFO - 'tpaint', 11:50:24 INFO - 'sessionrestore', 11:50:24 INFO - 'sessionrestore_no_auto_restore', 11:50:24 INFO - 'tabpaint']}, 11:50:24 INFO - 'other_nol64': {'tests': ['a11yr', 11:50:24 INFO - 'ts_paint', 11:50:24 INFO - 'tpaint', 11:50:24 INFO - 'sessionrestore', 11:50:24 INFO - 'sessionrestore_no_auto_restore', 11:50:24 INFO - 'tabpaint']}, 11:50:24 INFO - 'svgr': {'tests': ['tsvgx', 11:50:24 INFO - 'tsvgr_opacity', 11:50:24 INFO - 'tart', 11:50:24 INFO - 'tscrollx', 11:50:24 INFO - 'cart']}, 11:50:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:50:24 INFO - 'tests': ['tsvgx', 11:50:24 INFO - 'tsvgr_opacity', 11:50:24 INFO - 'tart', 11:50:24 INFO - 'tscrollx', 11:50:24 INFO - 'cart']}, 11:50:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:50:24 INFO - 'tests': ['tp5o']}, 11:50:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:50:24 INFO - 'talos_options': ['--e10s'], 11:50:24 INFO - 'tests': ['tp5o']}, 11:50:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:50:24 INFO - 'talos_options': ['--xperf_path', 11:50:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:50:24 INFO - 'tests': ['tp5n']}, 11:50:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:50:24 INFO - 'talos_options': ['--e10s', 11:50:24 INFO - '--xperf_path', 11:50:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:50:24 INFO - 'tests': ['tp5n']}}, 11:50:24 INFO - 'talos.zip': {'path': '', 11:50:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:50:24 INFO - Running post-action listener: _resource_record_post_action 11:50:24 INFO - ##### 11:50:24 INFO - ##### Running create-virtualenv step. 11:50:24 INFO - ##### 11:50:24 INFO - Running pre-action listener: _resource_record_pre_action 11:50:24 INFO - Running main action method: create_virtualenv 11:50:24 INFO - Creating virtualenv /builds/slave/test/build/venv 11:50:24 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 11:50:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:50:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:50:24 INFO - Using real prefix '/usr' 11:50:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:50:25 INFO - Installing distribute.............................................................................................................................................................................................done. 11:50:27 INFO - Installing pip.................done. 11:50:27 INFO - Return code: 0 11:50:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:50:27 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')]} 11:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:27 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')]} 11:50:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:27 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 0x7f744fdd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b08160>, '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 0x1b09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b094f0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', '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 11:50:27 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 11:50:27 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 11:50:27 INFO - Using env: {'DISPLAY': ':0', 11:50:27 INFO - 'HOME': '/home/cltbld', 11:50:27 INFO - 'LANG': 'en_US.UTF-8', 11:50:27 INFO - 'LANGUAGE': 'en_US:en', 11:50:27 INFO - 'LOGNAME': 'cltbld', 11:50:27 INFO - 'MAIL': '/var/mail/cltbld', 11:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:27 INFO - 'MOZ_NO_REMOTE': '1', 11:50:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:27 INFO - 'NO_EM_RESTART': '1', 11:50:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:27 INFO - 'PWD': '/builds/slave/test', 11:50:27 INFO - 'SHELL': '/bin/bash', 11:50:27 INFO - 'SHLVL': '1', 11:50:27 INFO - 'TERM': 'linux', 11:50:27 INFO - 'TMOUT': '86400', 11:50:27 INFO - 'USER': 'cltbld', 11:50:27 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', 11:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:27 INFO - '_': '/tools/buildbot/bin/python'} 11:50:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:27 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 11:50:27 INFO - Cleaning up... 11:50:27 INFO - Return code: 0 11:50:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:50:27 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')]} 11:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:27 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')]} 11:50:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:27 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f744fdd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b08160>, '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 0x1b09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b094f0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', '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 11:50:27 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>=0.7.1'] in /builds/slave/test/build 11:50:27 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>=0.7.1 11:50:27 INFO - Using env: {'DISPLAY': ':0', 11:50:27 INFO - 'HOME': '/home/cltbld', 11:50:27 INFO - 'LANG': 'en_US.UTF-8', 11:50:27 INFO - 'LANGUAGE': 'en_US:en', 11:50:27 INFO - 'LOGNAME': 'cltbld', 11:50:27 INFO - 'MAIL': '/var/mail/cltbld', 11:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:27 INFO - 'MOZ_NO_REMOTE': '1', 11:50:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:27 INFO - 'NO_EM_RESTART': '1', 11:50:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:27 INFO - 'PWD': '/builds/slave/test', 11:50:27 INFO - 'SHELL': '/bin/bash', 11:50:27 INFO - 'SHLVL': '1', 11:50:27 INFO - 'TERM': 'linux', 11:50:27 INFO - 'TMOUT': '86400', 11:50:27 INFO - 'USER': 'cltbld', 11:50:27 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', 11:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:27 INFO - '_': '/tools/buildbot/bin/python'} 11:50:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:27 INFO - Downloading/unpacking psutil>=0.7.1 11:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:50:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:50:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:50:29 INFO - Installing collected packages: psutil 11:50:29 INFO - Running setup.py install for psutil 11:50:29 INFO - building 'psutil._psutil_linux' extension 11:50:29 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 11:50:30 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 11:50:30 INFO - building 'psutil._psutil_posix' extension 11:50:30 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 11:50:30 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 11:50:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:50:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:50:30 INFO - Successfully installed psutil 11:50:30 INFO - Cleaning up... 11:50:30 INFO - Return code: 0 11:50:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f744fdd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b08160>, '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 0x1b09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b094f0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', '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 11:50:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:50:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:50:30 INFO - Using env: {'DISPLAY': ':0', 11:50:30 INFO - 'HOME': '/home/cltbld', 11:50:30 INFO - 'LANG': 'en_US.UTF-8', 11:50:30 INFO - 'LANGUAGE': 'en_US:en', 11:50:30 INFO - 'LOGNAME': 'cltbld', 11:50:30 INFO - 'MAIL': '/var/mail/cltbld', 11:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:30 INFO - 'MOZ_NO_REMOTE': '1', 11:50:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:30 INFO - 'NO_EM_RESTART': '1', 11:50:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:30 INFO - 'PWD': '/builds/slave/test', 11:50:30 INFO - 'SHELL': '/bin/bash', 11:50:30 INFO - 'SHLVL': '1', 11:50:30 INFO - 'TERM': 'linux', 11:50:30 INFO - 'TMOUT': '86400', 11:50:30 INFO - 'USER': 'cltbld', 11:50:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', 11:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:30 INFO - '_': '/tools/buildbot/bin/python'} 11:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:50:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:50:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:50:32 INFO - Installing collected packages: mozsystemmonitor 11:50:32 INFO - Running setup.py install for mozsystemmonitor 11:50:32 INFO - Successfully installed mozsystemmonitor 11:50:32 INFO - Cleaning up... 11:50:32 INFO - Return code: 0 11:50:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:32 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 0x7f744fdd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b08160>, '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 0x1b09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b094f0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', '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 11:50:32 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 11:50:32 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 11:50:32 INFO - Using env: {'DISPLAY': ':0', 11:50:32 INFO - 'HOME': '/home/cltbld', 11:50:32 INFO - 'LANG': 'en_US.UTF-8', 11:50:32 INFO - 'LANGUAGE': 'en_US:en', 11:50:32 INFO - 'LOGNAME': 'cltbld', 11:50:32 INFO - 'MAIL': '/var/mail/cltbld', 11:50:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:32 INFO - 'MOZ_NO_REMOTE': '1', 11:50:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:32 INFO - 'NO_EM_RESTART': '1', 11:50:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:32 INFO - 'PWD': '/builds/slave/test', 11:50:32 INFO - 'SHELL': '/bin/bash', 11:50:32 INFO - 'SHLVL': '1', 11:50:32 INFO - 'TERM': 'linux', 11:50:32 INFO - 'TMOUT': '86400', 11:50:32 INFO - 'USER': 'cltbld', 11:50:32 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', 11:50:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:32 INFO - '_': '/tools/buildbot/bin/python'} 11:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:32 INFO - Downloading/unpacking blobuploader==1.2.4 11:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:34 INFO - Downloading blobuploader-1.2.4.tar.gz 11:50:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:50:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:50:34 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 11:50:34 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 11:50:34 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 11:50:34 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 11:50:34 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 11:50:34 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 11:50:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:50:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:35 INFO - Downloading docopt-0.6.1.tar.gz 11:50:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:50:35 INFO - Installing collected packages: blobuploader, requests, docopt 11:50:35 INFO - Running setup.py install for blobuploader 11:50:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:50:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:50:35 INFO - Running setup.py install for requests 11:50:35 INFO - Running setup.py install for docopt 11:50:35 INFO - Successfully installed blobuploader requests docopt 11:50:35 INFO - Cleaning up... 11:50:35 INFO - Return code: 0 11:50:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:35 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 0x7f744fdd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b08160>, '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 0x1b09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b094f0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', '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 11:50:35 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 11:50:35 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 11:50:35 INFO - Using env: {'DISPLAY': ':0', 11:50:35 INFO - 'HOME': '/home/cltbld', 11:50:35 INFO - 'LANG': 'en_US.UTF-8', 11:50:35 INFO - 'LANGUAGE': 'en_US:en', 11:50:35 INFO - 'LOGNAME': 'cltbld', 11:50:35 INFO - 'MAIL': '/var/mail/cltbld', 11:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:35 INFO - 'MOZ_NO_REMOTE': '1', 11:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:35 INFO - 'NO_EM_RESTART': '1', 11:50:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:35 INFO - 'PWD': '/builds/slave/test', 11:50:35 INFO - 'SHELL': '/bin/bash', 11:50:35 INFO - 'SHLVL': '1', 11:50:35 INFO - 'TERM': 'linux', 11:50:35 INFO - 'TMOUT': '86400', 11:50:35 INFO - 'USER': 'cltbld', 11:50:35 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', 11:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:35 INFO - '_': '/tools/buildbot/bin/python'} 11:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:50:36 INFO - Running setup.py (path:/tmp/pip-cFxLyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:50:36 INFO - Running setup.py (path:/tmp/pip-Od5zD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:50:36 INFO - Running setup.py (path:/tmp/pip-QM0aAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:50:36 INFO - Running setup.py (path:/tmp/pip-bawo5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:50:36 INFO - Running setup.py (path:/tmp/pip-FUsirn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:50:36 INFO - Running setup.py (path:/tmp/pip-e3WEat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:50:36 INFO - Running setup.py (path:/tmp/pip-RL6MeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:50:36 INFO - Running setup.py (path:/tmp/pip-uNmJII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:50:36 INFO - Running setup.py (path:/tmp/pip-4Wg2y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:50:36 INFO - Running setup.py (path:/tmp/pip-6aQb9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:50:36 INFO - Running setup.py (path:/tmp/pip-hC7Eor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:50:36 INFO - Running setup.py (path:/tmp/pip-WnmCNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:50:37 INFO - Running setup.py (path:/tmp/pip-80ytui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:50:37 INFO - Running setup.py (path:/tmp/pip-Hi4B7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:37 INFO - Running setup.py (path:/tmp/pip-5X2Ah6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:50:37 INFO - Running setup.py (path:/tmp/pip-Utld5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:50:37 INFO - Running setup.py (path:/tmp/pip-SuiZbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:50:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:50:37 INFO - Running setup.py install for manifestparser 11:50:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:50:37 INFO - Running setup.py install for mozcrash 11:50:37 INFO - Running setup.py install for mozdebug 11:50:37 INFO - Running setup.py install for mozdevice 11:50:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:50:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:50:37 INFO - Running setup.py install for mozfile 11:50:37 INFO - Running setup.py install for mozhttpd 11:50:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:50:38 INFO - Running setup.py install for mozinfo 11:50:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:50:38 INFO - Running setup.py install for mozInstall 11:50:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:50:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:50:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:50:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:50:38 INFO - Running setup.py install for mozleak 11:50:38 INFO - Running setup.py install for mozlog 11:50:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:50:38 INFO - Running setup.py install for moznetwork 11:50:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:50:38 INFO - Running setup.py install for mozprocess 11:50:38 INFO - Running setup.py install for mozprofile 11:50:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:50:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:50:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:50:38 INFO - Running setup.py install for mozrunner 11:50:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:50:38 INFO - Running setup.py install for mozscreenshot 11:50:38 INFO - Running setup.py install for moztest 11:50:39 INFO - Running setup.py install for mozversion 11:50:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:50:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:50:39 INFO - Cleaning up... 11:50:39 INFO - Return code: 0 11:50:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f744fdd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b08160>, '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 0x1b09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b094f0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', '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 11:50:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:50:39 INFO - Using env: {'DISPLAY': ':0', 11:50:39 INFO - 'HOME': '/home/cltbld', 11:50:39 INFO - 'LANG': 'en_US.UTF-8', 11:50:39 INFO - 'LANGUAGE': 'en_US:en', 11:50:39 INFO - 'LOGNAME': 'cltbld', 11:50:39 INFO - 'MAIL': '/var/mail/cltbld', 11:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:39 INFO - 'MOZ_NO_REMOTE': '1', 11:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:39 INFO - 'NO_EM_RESTART': '1', 11:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:39 INFO - 'PWD': '/builds/slave/test', 11:50:39 INFO - 'SHELL': '/bin/bash', 11:50:39 INFO - 'SHLVL': '1', 11:50:39 INFO - 'TERM': 'linux', 11:50:39 INFO - 'TMOUT': '86400', 11:50:39 INFO - 'USER': 'cltbld', 11:50:39 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', 11:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:39 INFO - '_': '/tools/buildbot/bin/python'} 11:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:50:39 INFO - Running setup.py (path:/tmp/pip-X8nxpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:50:39 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)) 11:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:50:39 INFO - Running setup.py (path:/tmp/pip-h2rmVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:50:39 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)) 11:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:50:39 INFO - Running setup.py (path:/tmp/pip-xK8eMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:50:39 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)) 11:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:50:39 INFO - Running setup.py (path:/tmp/pip-6EUT2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:50:39 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)) 11:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:50:39 INFO - Running setup.py (path:/tmp/pip-tuITnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:50:39 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)) 11:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:50:39 INFO - Running setup.py (path:/tmp/pip-JFh5cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:50:39 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)) 11:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:50:39 INFO - Running setup.py (path:/tmp/pip-p0Jxv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:50:39 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)) 11:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:50:39 INFO - Running setup.py (path:/tmp/pip-yy2Owl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:50:39 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)) 11:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:50:40 INFO - Running setup.py (path:/tmp/pip-KSTU6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:50:40 INFO - Running setup.py (path:/tmp/pip-lDpsIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 11:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:50:40 INFO - Running setup.py (path:/tmp/pip-ZFGeF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:50:40 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)) 11:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:50:40 INFO - Running setup.py (path:/tmp/pip-MUQ46H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:50:40 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)) 11:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:50:40 INFO - Running setup.py (path:/tmp/pip-SiGMAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:50:40 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)) 11:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:50:40 INFO - Running setup.py (path:/tmp/pip-W2mOaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:50:40 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)) 11:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:40 INFO - Running setup.py (path:/tmp/pip-h5jsPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:40 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)) 11:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:50:40 INFO - Running setup.py (path:/tmp/pip-kMGRVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:50:40 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)) 11:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:50:40 INFO - Running setup.py (path:/tmp/pip-hixelf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:50:40 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)) 11:50:40 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)) 11:50:40 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)) 11:50:40 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)) 11:50:40 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)) 11:50:40 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)) 11:50:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:50:40 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 11:50:40 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 11:50:40 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 11:50:40 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 11:50:40 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 11:50:40 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 11:50:42 INFO - Downloading blessings-1.6.tar.gz 11:50:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:50:42 INFO - Installing collected packages: blessings 11:50:42 INFO - Running setup.py install for blessings 11:50:42 INFO - Successfully installed blessings 11:50:42 INFO - Cleaning up... 11:50:42 INFO - Return code: 0 11:50:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:50:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:50:42 INFO - Reading from file tmpfile_stdout 11:50:42 INFO - Current package versions: 11:50:42 INFO - argparse == 1.2.1 11:50:42 INFO - blessings == 1.6 11:50:42 INFO - blobuploader == 1.2.4 11:50:42 INFO - docopt == 0.6.1 11:50:42 INFO - manifestparser == 1.1 11:50:42 INFO - mozInstall == 1.12 11:50:42 INFO - mozcrash == 0.17 11:50:42 INFO - mozdebug == 0.1 11:50:42 INFO - mozdevice == 0.48 11:50:42 INFO - mozfile == 1.2 11:50:42 INFO - mozhttpd == 0.7 11:50:42 INFO - mozinfo == 0.9 11:50:42 INFO - mozleak == 0.1 11:50:42 INFO - mozlog == 3.1 11:50:42 INFO - moznetwork == 0.27 11:50:42 INFO - mozprocess == 0.22 11:50:42 INFO - mozprofile == 0.28 11:50:42 INFO - mozrunner == 6.11 11:50:42 INFO - mozscreenshot == 0.1 11:50:42 INFO - mozsystemmonitor == 0.0 11:50:42 INFO - moztest == 0.7 11:50:42 INFO - mozversion == 1.4 11:50:42 INFO - psutil == 3.1.1 11:50:42 INFO - requests == 1.2.3 11:50:42 INFO - wsgiref == 0.1.2 11:50:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:50: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')]} 11:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50: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')]} 11:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:42 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 0x7f744fdd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b08160>, '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 0x1b09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b094f0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', '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 11:50:42 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 11:50:42 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 11:50:42 INFO - Using env: {'DISPLAY': ':0', 11:50:42 INFO - 'HOME': '/home/cltbld', 11:50:42 INFO - 'LANG': 'en_US.UTF-8', 11:50:42 INFO - 'LANGUAGE': 'en_US:en', 11:50:42 INFO - 'LOGNAME': 'cltbld', 11:50:42 INFO - 'MAIL': '/var/mail/cltbld', 11:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:42 INFO - 'MOZ_NO_REMOTE': '1', 11:50:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:42 INFO - 'NO_EM_RESTART': '1', 11:50:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:42 INFO - 'PWD': '/builds/slave/test', 11:50:42 INFO - 'SHELL': '/bin/bash', 11:50:42 INFO - 'SHLVL': '1', 11:50:42 INFO - 'TERM': 'linux', 11:50:42 INFO - 'TMOUT': '86400', 11:50:42 INFO - 'USER': 'cltbld', 11:50:42 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', 11:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:42 INFO - '_': '/tools/buildbot/bin/python'} 11:50:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:43 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)) 11:50:43 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)) 11:50:43 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)) 11:50:43 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)) 11:50:43 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)) 11:50:43 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)) 11:50:43 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)) 11:50:43 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)) 11:50:43 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)) 11:50:43 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)) 11:50:43 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)) 11:50:43 INFO - Cleaning up... 11:50:43 INFO - Return code: 0 11:50:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:43 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 0x7f744fdd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b08160>, '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 0x1b09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b094f0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', '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 11:50:43 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 11:50:43 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 11:50:43 INFO - Using env: {'DISPLAY': ':0', 11:50:43 INFO - 'HOME': '/home/cltbld', 11:50:43 INFO - 'LANG': 'en_US.UTF-8', 11:50:43 INFO - 'LANGUAGE': 'en_US:en', 11:50:43 INFO - 'LOGNAME': 'cltbld', 11:50:43 INFO - 'MAIL': '/var/mail/cltbld', 11:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:43 INFO - 'MOZ_NO_REMOTE': '1', 11:50:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:43 INFO - 'NO_EM_RESTART': '1', 11:50:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:43 INFO - 'PWD': '/builds/slave/test', 11:50:43 INFO - 'SHELL': '/bin/bash', 11:50:43 INFO - 'SHLVL': '1', 11:50:43 INFO - 'TERM': 'linux', 11:50:43 INFO - 'TMOUT': '86400', 11:50:43 INFO - 'USER': 'cltbld', 11:50:43 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', 11:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:43 INFO - '_': '/tools/buildbot/bin/python'} 11:50:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:43 INFO - Downloading/unpacking jsonschema 11:50:43 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 11:50:43 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 11:50:43 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 11:50:43 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 11:50:43 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 11:50:43 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 11:50:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:50:45 INFO - Downloading/unpacking functools32 (from jsonschema) 11:50:45 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 11:50:45 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 11:50:45 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 11:50:45 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 11:50:45 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 11:50:45 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 11:50:45 INFO - Downloading functools32-3.2.3-2.tar.gz 11:50:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:50:45 INFO - warning: no files found matching '*.txt' 11:50:45 INFO - no previously-included directories found matching 'build' 11:50:45 INFO - no previously-included directories found matching 'dist' 11:50:45 INFO - no previously-included directories found matching '.git*' 11:50:45 INFO - Installing collected packages: jsonschema, functools32 11:50:45 INFO - Running setup.py install for functools32 11:50:45 INFO - warning: no files found matching '*.txt' 11:50:45 INFO - no previously-included directories found matching 'build' 11:50:45 INFO - no previously-included directories found matching 'dist' 11:50:45 INFO - no previously-included directories found matching '.git*' 11:50:45 INFO - Successfully installed jsonschema functools32 11:50:45 INFO - Cleaning up... 11:50:45 INFO - Return code: 0 11:50:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:50:45 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')]} 11:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:45 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')]} 11:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:45 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 0x7f744fdd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a79410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b08160>, '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 0x1b09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b094f0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', '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 11:50:45 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 11:50:45 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 11:50:45 INFO - Using env: {'DISPLAY': ':0', 11:50:45 INFO - 'HOME': '/home/cltbld', 11:50:45 INFO - 'LANG': 'en_US.UTF-8', 11:50:45 INFO - 'LANGUAGE': 'en_US:en', 11:50:45 INFO - 'LOGNAME': 'cltbld', 11:50:45 INFO - 'MAIL': '/var/mail/cltbld', 11:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:45 INFO - 'MOZ_NO_REMOTE': '1', 11:50:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:45 INFO - 'NO_EM_RESTART': '1', 11:50:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:45 INFO - 'PWD': '/builds/slave/test', 11:50:45 INFO - 'SHELL': '/bin/bash', 11:50:45 INFO - 'SHLVL': '1', 11:50:45 INFO - 'TERM': 'linux', 11:50:45 INFO - 'TMOUT': '86400', 11:50:45 INFO - 'USER': 'cltbld', 11:50:45 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', 11:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:45 INFO - '_': '/tools/buildbot/bin/python'} 11:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:45 INFO - Downloading/unpacking flake8 11:50:45 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 11:50:45 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 11:50:45 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 11:50:45 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 11:50:45 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 11:50:45 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 11:50:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:50:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:50:47 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 11:50:47 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 11:50:47 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 11:50:47 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 11:50:47 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 11:50:47 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 11:50:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:50:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:50:47 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 11:50:47 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 11:50:47 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 11:50:47 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 11:50:47 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 11:50:47 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 11:50:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:50:48 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 11:50:48 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 11:50:48 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 11:50:48 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 11:50:48 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 11:50:48 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 11:50:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:50:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:50:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:50:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:50:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:50:48 INFO - no previously-included directories found matching 'docs/_build' 11:50:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:50:48 INFO - Running setup.py install for pep8 11:50:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:50:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:50:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:50:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:50:48 INFO - no previously-included directories found matching 'docs/_build' 11:50:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:50:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:50:48 INFO - Cleaning up... 11:50:48 INFO - Return code: 0 11:50:48 INFO - Running post-action listener: _resource_record_post_action 11:50:48 INFO - Running post-action listener: _start_resource_monitoring 11:50:48 INFO - Starting resource monitoring. 11:50:48 INFO - ##### 11:50:48 INFO - ##### Running install step. 11:50:48 INFO - ##### 11:50:48 INFO - Running pre-action listener: _resource_record_pre_action 11:50:48 INFO - Running main action method: install 11:50:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:50:48 INFO - Reading from file tmpfile_stdout 11:50:48 INFO - Detecting whether we're running mozinstall >=1.0... 11:50:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:50:49 INFO - Reading from file tmpfile_stdout 11:50:49 INFO - Output received: 11:50:49 INFO - Usage: mozinstall [options] installer 11:50:49 INFO - Options: 11:50:49 INFO - -h, --help show this help message and exit 11:50:49 INFO - -d DEST, --destination=DEST 11:50:49 INFO - Directory to install application into. [default: 11:50:49 INFO - "/builds/slave/test"] 11:50:49 INFO - --app=APP Application being installed. [default: firefox] 11:50:49 INFO - mkdir: /builds/slave/test/build/application 11:50:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:50:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:51:04 INFO - Reading from file tmpfile_stdout 11:51:04 INFO - Output received: 11:51:04 INFO - /builds/slave/test/build/application/firefox/firefox 11:51:04 INFO - Running post-action listener: _resource_record_post_action 11:51:04 INFO - ##### 11:51:04 INFO - ##### Running run-tests step. 11:51:04 INFO - ##### 11:51:04 INFO - Running pre-action listener: _resource_record_pre_action 11:51:04 INFO - Running main action method: run_tests 11:51:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:51:04 INFO - Python 2.7.3 11:51:04 INFO - Return code: 0 11:51:04 INFO - grabbing minidump binary from tooltool 11:51: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')]} 11:51:04 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b08160>, '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 0x1b09060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b094f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:51:04 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 11:51:04 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 11:51:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:51:04 INFO - Return code: 0 11:51:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:51:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:51:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:51:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:51:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:51:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:51:05 INFO - Return code: 0 11:51:05 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:51:05 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:51:05 INFO - Using env: {'DISPLAY': ':0', 11:51:05 INFO - 'HOME': '/home/cltbld', 11:51:05 INFO - 'LANG': 'en_US.UTF-8', 11:51:05 INFO - 'LANGUAGE': 'en_US:en', 11:51:05 INFO - 'LOGNAME': 'cltbld', 11:51:05 INFO - 'MAIL': '/var/mail/cltbld', 11:51:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:51:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:05 INFO - 'MOZ_NO_REMOTE': '1', 11:51:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:05 INFO - 'NO_EM_RESTART': '1', 11:51:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:05 INFO - 'PWD': '/builds/slave/test', 11:51:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:51:05 INFO - 'SHELL': '/bin/bash', 11:51:05 INFO - 'SHLVL': '1', 11:51:05 INFO - 'TERM': 'linux', 11:51:05 INFO - 'TMOUT': '86400', 11:51:05 INFO - 'USER': 'cltbld', 11:51:05 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389', 11:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:05 INFO - '_': '/tools/buildbot/bin/python'} 11:51:05 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:51:06 INFO - mozversion application_buildid: 20160311110827 11:51:06 INFO - mozversion application_changeset: 5105e61dec9f879b87b374c4dd11981c9c18b7f3 11:51:06 INFO - mozversion application_display_name: Nightly 11:51:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:51:06 INFO - mozversion application_name: Firefox 11:51:06 INFO - mozversion application_remotingname: firefox 11:51:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:51:06 INFO - mozversion application_vendor: Mozilla 11:51:06 INFO - mozversion application_version: 48.0a1 11:51:06 INFO - mozversion platform_buildid: 20160311110827 11:51:06 INFO - mozversion platform_changeset: 5105e61dec9f879b87b374c4dd11981c9c18b7f3 11:51:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:51:06 INFO - mozversion platform_version: 48.0a1 11:51:06 INFO - using testdate: 1457725866 11:51:06 INFO - actual date: 1457725866 11:51:06 INFO - starting webserver on 'localhost:59389' 11:51:06 INFO - SUITE-START | Running 2 tests 11:51:06 INFO - TEST-START | dromaeo_css 11:51:06 INFO - operating with platform_type : linux_ 11:51:06 INFO - Initialising browser for dromaeo_css test... 11:51:06 INFO - TEST-INFO | started process 21994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoA16Td/profile http://localhost:59389/getInfo.html) 11:51:10 INFO - PROCESS | 21994 | __metrics Screen width/height:1600/1200 11:51:10 INFO - PROCESS | 21994 | colorDepth:24 11:51:10 INFO - PROCESS | 21994 | Browser inner width/height: 1024/697 11:51:10 INFO - PROCESS | 21994 | __metrics 11:51:11 ERROR - PROCESS | 21994 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:51:12 INFO - TEST-INFO | 21994: exit 0 11:51:12 INFO - Browser initialized. 11:51:12 INFO - Running cycle 1/1 for dromaeo_css test... 11:51:12 INFO - TEST-INFO | started process 22086 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoA16Td/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:51:24 INFO - PROCESS | 22086 | RSS: Main: 154451968 11:51:24 INFO - PROCESS | 22086 | 11:52:15 INFO - PROCESS | 22086 | 1457725935940 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] 11:54:27 INFO - PROCESS | 22086 | Cycle 1(1): loaded http://localhost:59389/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59389/tests/dromaeo/cssquery-ext.html) 11:54:28 INFO - PROCESS | 22086 | RSS: Main: 247144448 11:54:28 INFO - PROCESS | 22086 | 11:57:30 INFO - PROCESS | 22086 | Cycle 1(1): loaded http://localhost:59389/tests/dromaeo/cssquery-ext.html (next: http://localhost:59389/tests/dromaeo/cssquery-jquery.html) 11:57:31 INFO - PROCESS | 22086 | RSS: Main: 233525248 11:57:31 INFO - PROCESS | 22086 | 12:00:33 INFO - PROCESS | 22086 | Cycle 1(1): loaded http://localhost:59389/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59389/tests/dromaeo/cssquery-mootools.html) 12:00:33 INFO - PROCESS | 22086 | RSS: Main: 235155456 12:00:33 INFO - PROCESS | 22086 | 12:03:35 INFO - PROCESS | 22086 | Cycle 1(1): loaded http://localhost:59389/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59389/tests/dromaeo/cssquery-prototype.html) 12:03:36 INFO - PROCESS | 22086 | RSS: Main: 207646720 12:03:36 INFO - PROCESS | 22086 | 12:06:39 INFO - PROCESS | 22086 | Cycle 1(1): loaded http://localhost:59389/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59389/tests/dromaeo/cssquery-yui.html) 12:06:39 INFO - PROCESS | 22086 | RSS: Main: 222064640 12:06:39 INFO - PROCESS | 22086 | 12:09:42 INFO - PROCESS | 22086 | Cycle 1(1): loaded http://localhost:59389/tests/dromaeo/cssquery-yui.html (next: http://localhost:59389/tests/dromaeo/cssquery-dojo.html) 12:09:42 INFO - PROCESS | 22086 | RSS: Main: 266223616 12:09:42 INFO - PROCESS | 22086 | 12:09:42 INFO - PROCESS | 22086 | __start_tp_report 12:09:42 INFO - PROCESS | 22086 | _x_x_mozilla_page_load 12:09:42 INFO - PROCESS | 22086 | _x_x_mozilla_page_load_details 12:09:42 INFO - PROCESS | 22086 | |i|pagename|runs| 12:09:42 INFO - PROCESS | 22086 | |0;dojo.html;2622.265765585636;2669.799765017624;2682.8926842926285;2696.1372360844525;2716.2801857507766;4397.230484665187;4502.819887204508;4544.704594201375;4552.704074235173;4572.817087316512;4554.658400619958;4601.3558101865765;4635.490096089427;4639.721616703;4697.835575754849;4258.97870510647;4275.166342563201;4284.935725964113;4285.250081235787;4376.212281789277;4130.710850240484;4302.20409224293;4330.350447432895;4340.717853339539;4352.325389564607;4196.22369861575;4234.91530169398;4253.255680255943;4280;4302.225599392108;4233.25917964355;4235.174141042498;4237.0466645004935;4256.616904478581;4271.63691086258;4034.1729945361426;4173.24881521326;4214.831406743727;4220.282551966173;4260.573942605745;4503;4534.727916325031;4554.8405805796965;4564.2925346571;4594.977025114887;4903.779329930162;4915.926261106087;4917.4344950330815;4927.137750893615;4951.331570238044;4779.330893674888;4816.494268101834;4930.3344048553345;4947.554720075211;5000.099982003274;4528.682992190581;4538.341940418653;4542.659300552472;4580.129775342708;4591.540845915381;4967.925481117786;4980.950190498049;4981.875453113628;4983.476734942778;5033.446320904697;4712.575868171881;4787.329773831666;4816.277558366203;4859;4863.416390033148;4906.239532872411;4915.11527924977;4926.236433352836;4936.136176169156;4960.875978100504;4871.171900776805;4875.366202393666;4884.023195360942;4884.12085824555;4933.802647894044;4693.037927224911;4823.131836269435;4880.6095512358925;4904.313396124546;4914.926276105862;4127.422160897477;4129.442525259052;4131.669466442678;4136.8138433770555;4167.83328666856;3629.8366573504254;3641.235340578455;3645.343838109166;3662.9633703663153;3681.815909204529;4171.833126674899;4217.135487225173;4256.744595324229;4295.248331541968;4301.548337424525;4913.754312284372;4939.061578300111;4948.054410634651;4951.628627852925;4960.652754307164;4099.774512401847;4222.725522841006;4225.68307376948;4228.6617070634275;4263.531011588722;4318.093200427946;4376.3654270130655;4377.321515165155;4383.583559561836;4416.646668266531;4624.398828152319;4634.420697412824;4639.2113340731485;4660.300954856799;4698.7415692137265;4868.634852386014;4879.146149423766;4897.142999974919;4905.092557876804;4909.558139767438;4636.6058884995155;4656.697314674535;4660.976695116503;4663.533646635309;4712.858614241578;4890;4926.926096108489;4930.531599498042;4932.778024988956;4938.950610493849;4749.643776716829;4895.8041678332465;4958.231474121517;5015.548600625962;5041.1430056889685;4769.761511924459;4773.069251495925;4790.329353890388;4816.566509014206;4839.830605928775;4784.258439941815;4786.2581299898575;4795.520447955177;4796.2805579163405;4838.250071238964;4502.3246513023305;4694.2958556216845;4706.458757242961;4821.855344339676;4828.889355448337;4851.029794041277;4868.440129385024;4893.437254715611;4895.265710143507;4938.308636790924;4790.401199850019;4791.041791641616;4791.448983366958;4793.5685788279225;4802.567768900815 12:09:42 INFO - PROCESS | 22086 | |1;ext.html;512.3569919750712;515.7369741431874;522.208853586816;550.9256250406195;550.980685731397;32144.196395090104;32778;32899.177520562;32986.835065824635;33050.694930506936;40214.7989260054;41093;41194.58805411945;41302;41331.38002929959;7859.096203936563;8006.639701213459;8065.516069035877;8068.838623227532;8079.272865442109;7879.369650427952;7983.441159118864;8016.559089250118;8027.117017128111;8028.157043510435;7954.085280192794;8052.718154864581;8058.39562032847;8058.516489010678;8059.879101813477;7930.682772689085;7980.920190798134;8006.079300880357;8016.7194148204535;8017.797330400428;7916.722914697958;8048.396370272195;8052.59737013147;8053.677852885878;8055.516668999879;38009.619903800885;38575.614243857766;38577.22845543102;38618.80690596529;38702.419463708065;2939.1182645206354;2976.419598178356;2984.9850750746323;3000.804947678394;3108.5492603572357;28462;29072.27319317034;29181.56227656587;29354.197690112516;29733;3422.7775194612273;3426.1605906552804;3476.1830969722096;3551.627079156703;3568.6966607838367;232215;233254;233282;233297;233304;39279.607203928164;54807.451925480236;55118.17322740162;55173.44826551683;55173.72413137989;36676;36896.44655330172;36910.26179476395;36913;36948.44577331342;13014.609561713163;13256.204627722367;13287.933560332136;13293.335333233494;13299.534516291884;10375.84436233457;10423.061924426685;10432.321899076536;10433.16534677224;10437.165026797838;13176.143550669176;13223.603291901258;13645.795313070312;13678.93160534191;13765;5452.945470545323;5485.972570137204;5534.75093620788;5551.361593416728;5606.607537472338;858.7552547523926;871.3900269811157;886.1448702002598;895.6909866096187;906.551257127726;26256.73743262543;26902;27153.456930861666;27367.86316068447;27549.86225068902;802.8153524689354;909.0727457992942;991.3704797453669;1020.7244044108049;1080.5731735964407;11951.335281920712;13083;13352.866471335357;13393.598192054254;13432.932835335761;251412;251880;254654;255318;255969;43467.130657386675;43975.560244397784;44024.55975440269;44032;44101;1078.6817888722846;1124.7469319403233;1203.3501908969233;1214.4899142360407;1217.829503869459;23824.642630360213;24316.635250471612;26737.33156671099;27335;27436.862815686593;36960.445593315584;36991.630083698816;36994.26011479701;37073.629263707015;37151.62848371482;170986;173725;173841;173863;224120;28678;29065.34954407369;29102.70897291;29116.563251551666;29286;33347;33998.150046249044;34521.82739086288;34553.30893382169;34909.65090349064;29318.7068129316;29732;32126;32159.196020099684;32231.516527251642;31961.68038319587;32020.6797932027;32172.19569510781;32466;32717.345653087283;32156.03531894047;32580;32792.180195495304;32997.34005319928;33100.66899330976;26313.605295920195;28957.276068098465;29024.854875725487;29047.12858614245;29124.563131553467;23212.883935580216;23295.41761455977;23373.532529349657;23543.764562354158;23574 12:09:42 INFO - PROCESS | 22086 | |2;jquery.html;284.7807188464882;324.81485553234666;325.83870983862994;327.3649120705832;340.1954377896276;14028.228447435387;15280.84719152808;15297.541073767778;15816.525504234862;15840;13985.300734963263;14145.929270353634;14309;14654.48709295175;15755.527334179964;5017.573506251963;5177.068127737006;5179.870503237412;5193.402758682743;5197.584193264549;4917.7541122943885;5040.269160971657;5108.514691104339;5109.131447653889;5138.8715282118055;5040.42035165957;5065.949340506585;5067.037262920052;5084.84745457635;5088.669236499616;4915.016996600659;5009.4239162496415;5034.723090230036;5035.144025515671;5045.823396181135;4478.373027776114;4518.164139634146;4520.977395113036;4522.479914809774;4524.61540769035;18354.541136471562;18431.539211519685;18568.350107746162;19214.711779323323;19234.422967311002;1845.2987864611362;1881.3227238194238;2356.8215892053972;2421.0651497433137;2467.679201703785;11967.281963082156;11988.160828741991;12406.193597416139;12561.685957851036;12597.937010314981;1750.9912450437666;1810.4930619426582;1817;1824.6624374490762;1839.8620103492292;49736.25395619069;52001;52306.738466307805;52452.47547524514;52516.474835251924;9393;9969.202463802878;10101.848472272775;10158;10216.131628811485;12578.68553286157;12712.872871271169;12719.427625756864;12723.936380318224;12825.551105711254;7058;7133.928660713326;7167.605781681953;7242.9275707243305;7288.3076107769675;6882.621455819978;7004.122698655986;7077.469189810682;7105.969634403086;7165.3551180394015;4241.575842415734;4327.480702315742;4340.348947657877;4387.429634147604;4406.405135306757;1751.509577318353;1763.647270545896;1768.2219823277717;1773.742807292961;1774.157275294225;756.5763172623349;878.8901387326584;899.9145081217274;950.6862735297335;978.8433850583872;14639.560813175622;14686.118832870063;14810.555683329518;15183.392664293304;15768.92115539415;806.749907528668;813.8616435206029;825.8761185822175;847.6651722569551;858.9484630922165;8957.193852553302;9054.502002389932;9184.540772961325;9210.35527513081;9339.579718912666;344040;349353;350474;357452;369404;61779;62326.37673623297;62556.37443625506;62772;63323.683381583716;754.8980887580107;761.1399118995499;778.4356341652257;778.9922100779033;779.7738655789757;13664.521741738992;13955;14195.574132776033;14283.143011419348;14360.640983975483;28698.56952145678;29027.56458653164;29828.552571711876;30185.69814301829;30403.087907362813;36456.08859778527;37461.62538374581;37519.24961500809;37778.62221377861;37833.62166378411;6869.656517174021;6931.89602155958;6997.755078572225;7099.361057504642;7214.567125972459;8498.915010849812;10286.177105831664;10390.792184156124;10456.111230545488;10662.200334974752;8957.686480973134;9180.954095229481;9235.26117910579;9259.398139120936;9364.157225849434;8964.372493925363;9173.220276276325;9212.723618291462;9257.677689376162;9471.384360016576;9220.44677319363;9530.332876698565;9696.321257511907;9701.126898579161;9804.803903922024;6721.655668866344;7018.543794653331;7021.017057611836;7128.108986376703;7146.428285737024;7338.669759860926;8888.77778055528;9284.442933424016;9418.81162376735;9572.042795720372 12:09:42 INFO - PROCESS | 22086 | |3;mootools.html;1232.0451649971276;1378.1042322490382;1379.6895698467847;1509.3962415033984;1737.6437830244802;7152.1417429908415;7269.3457588817;7272.090988626422;7277.781666550005;7303.525270857391;7100.502964792467;7270.709171633128;7286.489945703803;7288.307610776981;7296.890546641805;1799.7300404939233;1850.69463538516;1853.6756067688168;2098.485870961613;2126.5959467701164;2095.7275554177936;2132.4882028313173;2146.838987075968;2148.376970678509;2149.849510534263;2079.085202510898;2112.1551379448265;2121.1621409543222;2121.649927761925;2153.7953894380007;2128.31893793986;2135.508832968426;2136.797004284598;2141.4111119442277;2141.6145093883174;2052.1688716070016;2143.121320258702;2145.978540214609;2146.409737322249;2146.7960543748477;7414.59219742914;7452.552846829208;7455.4408419368765;7456.291652293077;7468.439867009996;4199.68502362321;4272.4445822042935;4297.699161058727;4302.075053863403;4313.892152696177;2741.4105967217142;2783.9304017399522;2882.7405533502088;2883.7548808351316;2884.120343295294;888.595688961521;905.1039470923804;906.7551761024487;910.4446287764458;937.7983733497263;10119.645812396604;10128.240381971382;10154.695359139163;10202.183825293958;10203.846942295871;3942.901427464279;4096.836126554964;4171;4190.622843943998;4190.622843944059;8587.699430519902;8634.827303454022;8647.26498247656;8656.697015604424;8658.567071646392;4440;4443.244648409714;4443.666724995638;4445.666575006888;4448.35498852671;3281.343731253759;3751.5685696144747;3842;3989.261986532501;3992.381180916904;3406.114410253352;3406.2335974406055;3408.9829550852087;3466.4973578830927;3508.649135086471;1072.570971611346;1083.06315037492;1094.4308959341258;1099.1646348774989;1101.3557069114659;943.556528431636;949.8955114937352;959.5490119643756;995.2088089968493;1212.5755985405215;7033.050538177383;7045.7533986311255;7050.541714788523;7072.434205263567;7079.150501939697;439.49238629383115;444.7042716593494;456.3474231848422;457.04249597094037;457.49903855278416;5351.357837059578;5356.7857285708915;5374.811881584125;5380.408155102936;5412.648177868426;8369.288610468178;8455.830883382421;8487.278581320534;8588.957055214683;8685.739427817049;8465.619047142893;8522.659093636184;8525.232729054414;8535.53054582004;8563.272121869712;6968.860622787516;7021.508494405342;7169.318914703095;7183.89224161638;7232.855342893218;6837;6866.622335771581;6871.793846184622;6872.793816185523;6872.828179295558;8044.436889417684;8133.024037115584;8143.022837259567;8163.306118979954;8267.917320826955;7774.844503110019;7965.522068675898;8046.074701409413;8054.476459030145;8067.636956336862;6395.488360931021;6469.5794773339585;6501.3823686751575;6522.673866306571;6525.673716314071;7060.576365418091;7064.82337941535;7104.076470058859;7123.038389817309;7128.358447739728;6309.747610095545;6392.360763923571;6484.935150648433;6517.315681853527;6554.573952693059;6092.329843717099;6450.548461607643;6476.093346931528;6546.345365463416;6575.408213260829;6382.648954307558;6428.903566446601;6443.323451037573;6444.613323200623;6451.774187903588;5976.103584462366;5983.072623743326;5989.3112292085225;6072.72672729737;6137.294211165595;6020.548458865515;6062.605930614496;6070.0591408331775;6083.391660833881;6100.511959043355 12:09:42 INFO - PROCESS | 22086 | |4;prototype.html;302.82436187011524;304.65573901491314;305.770671996003;313.5375321400934;314.7371944426404;5201.843944681661;5258.158694608864;5269.130593452081;5331.067063263933;5406.756695948682;5255.264263003182;5319.414864364927;5341.599380046493;5343.492368225013;5359.222912677669;3891.6886649068006;3953.5058117735284;4033.838646454138;4096.774677392742;4118.6499147572495;4058.1883623275316;4082.4284600156;4084.5098588169462;4089.284375234337;4094.2425651254466;4028.5769994150633;4045.5954404559457;4050.9392359114636;4055.5944405559503;4061.3501839705655;3825.1393436476847;3984.1234928315725;4076.673866090706;4081.673466122733;4082.4488694026522;3529.8411571479087;3542.5394698689265;3542.7697199682198;3557.4485954677066;3559.7330200235087;5148.382194136728;5148.536631703165;5155.819546315861;5158.200478925773;5161.638685292031;4666.323383109464;4679.789409476582;4680.695754775928;4680.882977925545;4683.625309975194;5578.553715702734;5581.916271255935;5583.330000399978;5586.832395028156;5586.91619625706;3861.498005259298;3864.0726225705907;3864.478295430109;3865.8260378283044;3867.5552311484257;5588.189712491666;5837.620554663933;5846.50304724099;5850.795222167247;5855.121731740231;3918.1771827915886;3935.4293627423863;3939.113699417608;3943.211357728466;3943.921121577552;4000.419939108871;4005.399190121505;4007.458993035961;4008.8596899108393;4009.859654912064;4622.19111655459;4624.838130665411;4626.791794369262;4628.884277893079;4634.49378951842;5537.667739935617;5584.86037849057;5589.74846131925;5592.077307244341;5603.075492543766;1386.7850483175123;1420.2756594137065;1420.82239720035;1421.8435972043067;1423.5302350224401;904.5477261369315;932.1051790281406;936.7049379445452;945.1257586732245;966;4855.732934688555;4870.829520966749;4876.097921884463;4889.755512224375;4889.804407823718;5770.884582308414;5772.134179873053;5773.278340207474;5781.71091445426;5797.594168408171;4826.493218212107;4860.659753817199;4861.465238823726;4869.220924652039;4869.805207791649;3084.892028779027;3106.4563701352627;3108.518179682153;3111.284404586958;3111.471049921519;5432.538234250054;5440.319960004999;5443.564514838803;5446.727663616883;5457.590680698963;5680.801171958961;5890.9410905891245;5918.526517878559;5927.614705044159;5931.051031834886;5402.108652072443;5421.26812880264;5430.755615997289;5432.7555260012605;5434.266374039454;5740.311162660508;5744.195812586325;5747.396523364986;5750.539956803529;5757.309122905278;5633.408492108433;5647.3787883333625;5648.322201335866;5649;5651.180578816131;5415.323084614423;5415.458454154553;5420.457954204548;5422.918656220081;5427.48438898304;3802.16352402471;3915.7063220259165;3924.117073658404;3928.9607103928593;3963.4253033310583;5515.0348688978465;5668.51817595509;5688.175214593944;5757.165211044291;5759.452851979056;5405.837824865261;5502.174673798962;5513.889722205453;5516.889662206813;5531.751071201886;5594.720263986703;5597.412271711574;5599.440055994368;5607.495325420732;5609.74756135983;5463.399026107046;5487.807926722546;5491.478309560585;5494.175873618829;5495.203195536705;5639.971800140973;5644;5645.435456454322;5645.633033852787;5648.23748793924;5279.392869819866;5446.046941785251;5450.945490545044;5451.863703407288;5487.780488780404 12:09:42 INFO - PROCESS | 22086 | |5;yui.html;567.5884983387042;594.4768603628806;651.094977980607;673.1484671890058;682.1575354437269;10467.424291663956;10584.841227381596;10588.894111058888;10625.309354891926;10659;11235.438228088604;11309.943450282737;11323.094152467804;11335.37655428951;11350.148738844578;600.8017354273079;773.736929443989;783.3733013589134;794.9682012719484;798.2376830127215;791.2680770287461;793.1513280789558;795.4908858330673;795.8885755994165;797.1868693932186;834.1283358889974;836.0469065265602;837.0081453477618;837.3301358912845;837.4556538250156;631.0376675569747;814.5031530766257;828.6395417993192;830.2901019628251;830.7092517618815;613.0467123622765;613.4846728747829;613.6348872420903;614.1586027142798;614.9938500614982;11606.36165010924;11645.767084658344;11654.359010254433;11679.065674746;11688.883111168865;10390.324628899098;11050.668479945614;11076.833847492295;11236.269642473295;11307.547698092067;8898.86651700225;9044.54777261141;9073.7277881663;9313.394629349139;9392.013838546922;3132.1699749566383;3134.717875391203;3174.1271150433818;3180.0459862041293;3219.307848812493;39745;40759.796201019104;41020.974475638046;41180.588194117976;41361;8854.955725221462;8979.820403591892;9014;9076.31927605419;9185.678501252423;16385.50843474698;16398.344066237456;16409.179541022902;16413.343466261456;16460.506184814476;6033.215681961317;6183;6351.460125889259;6391.265004524446;6543.869122617521;3383.8477268522483;3399.5920489541413;3418.81196534193;3443.1908501502126;3450.344434557426;2768.612394264764;2822.618946442204;2825.788065895066;2831.66020077592;2832.3910359272854;428.91207302502914;484.69706433479075;509.5745052880812;511.34292434221845;530.1941049604579;456.8766433063054;490.4188536584159;514.4803748214256;518.3391176250236;531.1952392125933;6736.7642132525125;6811.829704257433;6832.965835170892;6993.090898183305;7043.260457651975;527.4725274725274;533.981310654133;536.704812353212;540.0899484368852;542.4494138449477;3336.6830151136087;3356.848941797625;3396.745244106702;3404.5063465797816;3459.377312083849;48667.513324867;48810.755946220044;49386;49405.75297123491;49451;42004.78997604993;42876;43192.784036080244;43215.567844321784;43356.56643433588;39102.41346379807;39444;39549.80225098856;39869.60130398717;40060.799696001915;7030.753923612649;7244.927550724426;7295.635218239173;7342.632868356668;7348.191698913222;30461.23846903845;30778.692213077582;31770;31803.68196318007;31819.04542863718;35432;36702.265954681294;38115.80942095272;39445.60554394419;39503.20993580055;8332.50004999702;8556.700515481929;8600.78498037554;8640.438371505832;8645.567721613768;9334.486603236886;9385.765355866159;9486.810263794547;9575.808483830424;9599.520023998912;7773.37812974972;8688.43608150539;8994.955025224832;9213.631454741735;9380.906190938003;9342.95328523353;9495.572699228689;9495.810083798424;9594.376365536218;9715.514224288616;9721.805563888824;9798.461084640414;9988.800223995335;10012.499375031364;10133.594656213669;8686.565671716262;8689.348298877736;8702.129787021247;8707.608157632794;8709.303255739398;8764;9195.126462986005;9214.953925230599;9235.492047937429;9317.39436936597 12:09:42 INFO - PROCESS | 22086 | __end_tp_report 12:09:42 INFO - PROCESS | 22086 | __start_cc_report 12:09:42 INFO - PROCESS | 22086 | _x_x_mozilla_cycle_collect,916 12:09:42 INFO - PROCESS | 22086 | __end_cc_report 12:09:42 INFO - PROCESS | 22086 | __startTimestamp1457726982343__endTimestamp 12:09:42 INFO - PROCESS | 22086 | 12:09:42 INFO - PROCESS | 22086 | ------- Summary: start ------- 12:09:42 INFO - PROCESS | 22086 | Number of tests: 6 12:09:42 INFO - PROCESS | 22086 | 12:09:42 INFO - PROCESS | 22086 | [#0] dojo.html Cycles:165 Average:4548.20 Median:4663.53 stddev:462.69 (9.9%) stddev-sans-first:438.74 12:09:42 INFO - PROCESS | 22086 | Values: 2622.3 2669.8 2682.9 2696.1 2716.3 4397.2 4502.8 4544.7 4552.7 4572.8 4554.7 4601.4 4635.5 4639.7 4697.8 4259.0 4275.2 4284.9 4285.3 4376.2 4130.7 4302.2 4330.4 4340.7 4352.3 4196.2 4234.9 4253.3 4280.0 4302.2 4233.3 4235.2 4237.0 4256.6 4271.6 4034.2 4173.2 4214.8 4220.3 4260.6 4503.0 4534.7 4554.8 4564.3 4595.0 4903.8 4915.9 4917.4 4927.1 4951.3 4779.3 4816.5 4930.3 4947.6 5000.1 4528.7 4538.3 4542.7 4580.1 4591.5 4967.9 4981.0 4981.9 4983.5 5033.4 4712.6 4787.3 4816.3 4859.0 4863.4 4906.2 4915.1 4926.2 4936.1 4960.9 4871.2 4875.4 4884.0 4884.1 4933.8 4693.0 4823.1 4880.6 4904.3 4914.9 4127.4 4129.4 4131.7 4136.8 4167.8 3629.8 3641.2 3645.3 3663.0 3681.8 4171.8 4217.1 4256.7 4295.2 4301.5 4913.8 4939.1 4948.1 4951.6 4960.7 4099.8 4222.7 4225.7 4228.7 4263.5 4318.1 4376.4 4377.3 4383.6 4416.6 4624.4 4634.4 4639.2 4660.3 4698.7 4868.6 4879.1 4897.1 4905.1 4909.6 4636.6 4656.7 4661.0 4663.5 4712.9 4890.0 4926.9 4930.5 4932.8 4939.0 4749.6 4895.8 4958.2 5015.5 5041.1 4769.8 4773.1 4790.3 4816.6 4839.8 4784.3 4786.3 4795.5 4796.3 4838.3 4502.3 4694.3 4706.5 4821.9 4828.9 4851.0 4868.4 4893.4 4895.3 4938.3 4790.4 4791.0 4791.4 4793.6 4802.6 12:09:42 INFO - PROCESS | 22086 | 12:09:42 INFO - PROCESS | 22086 | [#1] ext.html Cycles:180 Average:37542.01 Median:32785.09 stddev:58712.57 (179.1%) stddev-sans-first:58811.44 12:09:42 INFO - PROCESS | 22086 | Values: 512.4 515.7 522.2 550.9 551.0 32144.2 32778.0 32899.2 32986.8 33050.7 40214.8 41093.0 41194.6 41302.0 41331.4 7859.1 8006.6 8065.5 8068.8 8079.3 7879.4 7983.4 8016.6 8027.1 8028.2 7954.1 8052.7 8058.4 8058.5 8059.9 7930.7 7980.9 8006.1 8016.7 8017.8 7916.7 8048.4 8052.6 8053.7 8055.5 38009.6 38575.6 38577.2 38618.8 38702.4 2939.1 2976.4 2985.0 3000.8 3108.5 28462.0 29072.3 29181.6 29354.2 29733.0 3422.8 3426.2 3476.2 3551.6 3568.7 232215.0 233254.0 233282.0 233297.0 233304.0 39279.6 54807.5 55118.2 55173.4 55173.7 36676.0 36896.4 36910.3 36913.0 36948.4 13014.6 13256.2 13287.9 13293.3 13299.5 10375.8 10423.1 10432.3 10433.2 10437.2 13176.1 13223.6 13645.8 13678.9 13765.0 5452.9 5486.0 5534.8 5551.4 5606.6 858.8 871.4 886.1 895.7 906.6 26256.7 26902.0 27153.5 27367.9 27549.9 802.8 909.1 991.4 1020.7 1080.6 11951.3 13083.0 13352.9 13393.6 13432.9 251412.0 251880.0 254654.0 255318.0 255969.0 43467.1 43975.6 44024.6 44032.0 44101.0 1078.7 1124.7 1203.4 1214.5 1217.8 23824.6 24316.6 26737.3 27335.0 27436.9 36960.4 36991.6 36994.3 37073.6 37151.6 170986.0 173725.0 173841.0 173863.0 224120.0 28678.0 29065.3 29102.7 29116.6 29286.0 33347.0 33998.2 34521.8 34553.3 34909.7 29318.7 29732.0 32126.0 32159.2 32231.5 31961.7 32020.7 32172.2 32466.0 32717.3 32156.0 32580.0 32792.2 32997.3 33100.7 26313.6 28957.3 29024.9 29047.1 29124.6 23212.9 23295.4 23373.5 23543.8 23574.0 12:09:42 INFO - PROCESS | 22086 | 12:09:42 INFO - PROCESS | 22086 | [#2] jquery.html Cycles:180 Average:21397.63 Median:5013.50 stddev:57993.61 (1156.7%) stddev-sans-first:58134.63 12:09:42 INFO - PROCESS | 22086 | Values: 284.8 324.8 325.8 327.4 340.2 14028.2 15280.8 15297.5 15816.5 15840.0 13985.3 14145.9 14309.0 14654.5 15755.5 5017.6 5177.1 5179.9 5193.4 5197.6 4917.8 5040.3 5108.5 5109.1 5138.9 5040.4 5065.9 5067.0 5084.8 5088.7 4915.0 5009.4 5034.7 5035.1 5045.8 4478.4 4518.2 4521.0 4522.5 4524.6 18354.5 18431.5 18568.4 19214.7 19234.4 1845.3 1881.3 2356.8 2421.1 2467.7 11967.3 11988.2 12406.2 12561.7 12597.9 1751.0 1810.5 1817.0 1824.7 1839.9 49736.3 52001.0 52306.7 52452.5 52516.5 9393.0 9969.2 10101.8 10158.0 10216.1 12578.7 12712.9 12719.4 12723.9 12825.6 7058.0 7133.9 7167.6 7242.9 7288.3 6882.6 7004.1 7077.5 7106.0 7165.4 4241.6 4327.5 4340.3 4387.4 4406.4 1751.5 1763.6 1768.2 1773.7 1774.2 756.6 878.9 899.9 950.7 978.8 14639.6 14686.1 14810.6 15183.4 15768.9 806.7 813.9 825.9 847.7 858.9 8957.2 9054.5 9184.5 9210.4 9339.6 344040.0 349353.0 350474.0 357452.0 369404.0 61779.0 62326.4 62556.4 62772.0 63323.7 754.9 761.1 778.4 779.0 779.8 13664.5 13955.0 14195.6 14283.1 14360.6 28698.6 29027.6 29828.6 30185.7 30403.1 36456.1 37461.6 37519.2 37778.6 37833.6 6869.7 6931.9 6997.8 7099.4 7214.6 8498.9 10286.2 10390.8 10456.1 10662.2 8957.7 9181.0 9235.3 9259.4 9364.2 8964.4 9173.2 9212.7 9257.7 9471.4 9220.4 9530.3 9696.3 9701.1 9804.8 6721.7 7018.5 7021.0 7128.1 7146.4 7338.7 8888.8 9284.4 9418.8 9572.0 12:09:42 INFO - PROCESS | 22086 | 12:09:42 INFO - PROCESS | 22086 | [#3] mootools.html Cycles:180 Average:5099.46 Median:6118.90 stddev:2697.91 (44.1%) stddev-sans-first:2689.82 12:09:42 INFO - PROCESS | 22086 | Values: 1232.0 1378.1 1379.7 1509.4 1737.6 7152.1 7269.3 7272.1 7277.8 7303.5 7100.5 7270.7 7286.5 7288.3 7296.9 1799.7 1850.7 1853.7 2098.5 2126.6 2095.7 2132.5 2146.8 2148.4 2149.8 2079.1 2112.2 2121.2 2121.6 2153.8 2128.3 2135.5 2136.8 2141.4 2141.6 2052.2 2143.1 2146.0 2146.4 2146.8 7414.6 7452.6 7455.4 7456.3 7468.4 4199.7 4272.4 4297.7 4302.1 4313.9 2741.4 2783.9 2882.7 2883.8 2884.1 888.6 905.1 906.8 910.4 937.8 10119.6 10128.2 10154.7 10202.2 10203.8 3942.9 4096.8 4171.0 4190.6 4190.6 8587.7 8634.8 8647.3 8656.7 8658.6 4440.0 4443.2 4443.7 4445.7 4448.4 3281.3 3751.6 3842.0 3989.3 3992.4 3406.1 3406.2 3409.0 3466.5 3508.6 1072.6 1083.1 1094.4 1099.2 1101.4 943.6 949.9 959.5 995.2 1212.6 7033.1 7045.8 7050.5 7072.4 7079.2 439.5 444.7 456.3 457.0 457.5 5351.4 5356.8 5374.8 5380.4 5412.6 8369.3 8455.8 8487.3 8589.0 8685.7 8465.6 8522.7 8525.2 8535.5 8563.3 6968.9 7021.5 7169.3 7183.9 7232.9 6837.0 6866.6 6871.8 6872.8 6872.8 8044.4 8133.0 8143.0 8163.3 8267.9 7774.8 7965.5 8046.1 8054.5 8067.6 6395.5 6469.6 6501.4 6522.7 6525.7 7060.6 7064.8 7104.1 7123.0 7128.4 6309.7 6392.4 6484.9 6517.3 6554.6 6092.3 6450.5 6476.1 6546.3 6575.4 6382.6 6428.9 6443.3 6444.6 6451.8 5976.1 5983.1 5989.3 6072.7 6137.3 6020.5 6062.6 6070.1 6083.4 6100.5 12:09:42 INFO - PROCESS | 22086 | 12:09:42 INFO - PROCESS | 22086 | [#4] prototype.html Cycles:180 Average:4600.42 Median:5325.24 stddev:1360.74 (25.6%) stddev-sans-first:1325.77 12:09:42 INFO - PROCESS | 22086 | Values: 302.8 304.7 305.8 313.5 314.7 5201.8 5258.2 5269.1 5331.1 5406.8 5255.3 5319.4 5341.6 5343.5 5359.2 3891.7 3953.5 4033.8 4096.8 4118.6 4058.2 4082.4 4084.5 4089.3 4094.2 4028.6 4045.6 4050.9 4055.6 4061.4 3825.1 3984.1 4076.7 4081.7 4082.4 3529.8 3542.5 3542.8 3557.4 3559.7 5148.4 5148.5 5155.8 5158.2 5161.6 4666.3 4679.8 4680.7 4680.9 4683.6 5578.6 5581.9 5583.3 5586.8 5586.9 3861.5 3864.1 3864.5 3865.8 3867.6 5588.2 5837.6 5846.5 5850.8 5855.1 3918.2 3935.4 3939.1 3943.2 3943.9 4000.4 4005.4 4007.5 4008.9 4009.9 4622.2 4624.8 4626.8 4628.9 4634.5 5537.7 5584.9 5589.7 5592.1 5603.1 1386.8 1420.3 1420.8 1421.8 1423.5 904.5 932.1 936.7 945.1 966.0 4855.7 4870.8 4876.1 4889.8 4889.8 5770.9 5772.1 5773.3 5781.7 5797.6 4826.5 4860.7 4861.5 4869.2 4869.8 3084.9 3106.5 3108.5 3111.3 3111.5 5432.5 5440.3 5443.6 5446.7 5457.6 5680.8 5890.9 5918.5 5927.6 5931.1 5402.1 5421.3 5430.8 5432.8 5434.3 5740.3 5744.2 5747.4 5750.5 5757.3 5633.4 5647.4 5648.3 5649.0 5651.2 5415.3 5415.5 5420.5 5422.9 5427.5 3802.2 3915.7 3924.1 3929.0 3963.4 5515.0 5668.5 5688.2 5757.2 5759.5 5405.8 5502.2 5513.9 5516.9 5531.8 5594.7 5597.4 5599.4 5607.5 5609.7 5463.4 5487.8 5491.5 5494.2 5495.2 5640.0 5644.0 5645.4 5645.6 5648.2 5279.4 5446.0 5450.9 5451.9 5487.8 12:09:42 INFO - PROCESS | 22086 | 12:09:42 INFO - PROCESS | 22086 | [#5] yui.html Cycles:180 Average:11781.27 Median:541.27 stddev:13597.26 (2512.1%) stddev-sans-first:13609.33 12:09:42 INFO - PROCESS | 22086 | Values: 567.6 594.5 651.1 673.1 682.2 10467.4 10584.8 10588.9 10625.3 10659.0 11235.4 11309.9 11323.1 11335.4 11350.1 600.8 773.7 783.4 795.0 798.2 791.3 793.2 795.5 795.9 797.2 834.1 836.0 837.0 837.3 837.5 631.0 814.5 828.6 830.3 830.7 613.0 613.5 613.6 614.2 615.0 11606.4 11645.8 11654.4 11679.1 11688.9 10390.3 11050.7 11076.8 11236.3 11307.5 8898.9 9044.5 9073.7 9313.4 9392.0 3132.2 3134.7 3174.1 3180.0 3219.3 39745.0 40759.8 41021.0 41180.6 41361.0 8855.0 8979.8 9014.0 9076.3 9185.7 16385.5 16398.3 16409.2 16413.3 16460.5 6033.2 6183.0 6351.5 6391.3 6543.9 3383.8 3399.6 3418.8 3443.2 3450.3 2768.6 2822.6 2825.8 2831.7 2832.4 428.9 484.7 509.6 511.3 530.2 456.9 490.4 514.5 518.3 531.2 6736.8 6811.8 6833.0 6993.1 7043.3 527.5 534.0 536.7 540.1 542.4 3336.7 3356.8 3396.7 3404.5 3459.4 48667.5 48810.8 49386.0 49405.8 49451.0 42004.8 42876.0 43192.8 43215.6 43356.6 39102.4 39444.0 39549.8 39869.6 40060.8 7030.8 7244.9 7295.6 7342.6 7348.2 30461.2 30778.7 31770.0 31803.7 31819.0 35432.0 36702.3 38115.8 39445.6 39503.2 8332.5 8556.7 8600.8 8640.4 8645.6 9334.5 9385.8 9486.8 9575.8 9599.5 7773.4 8688.4 8995.0 9213.6 9380.9 9343.0 9495.6 9495.8 9594.4 9715.5 9721.8 9798.5 9988.8 10012.5 10133.6 8686.6 8689.3 8702.1 8707.6 8709.3 8764.0 9195.1 9215.0 9235.5 9317.4 12:09:42 INFO - PROCESS | 22086 | -------- Summary: end -------- 12:09:42 INFO - PROCESS | 22086 | 12:09:43 INFO - TEST-INFO | 22086: exit 0 12:09:43 INFO - TEST-OK | dromaeo_css | took 1116996ms 12:09:43 INFO - TEST-START | kraken 12:09:43 INFO - operating with platform_type : linux_ 12:09:43 INFO - Initialising browser for kraken test... 12:09:43 INFO - TEST-INFO | started process 22264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1hglan/profile http://localhost:59389/getInfo.html) 12:09:47 INFO - PROCESS | 22264 | __metrics Screen width/height:1600/1200 12:09:47 INFO - PROCESS | 22264 | colorDepth:24 12:09:47 INFO - PROCESS | 22264 | Browser inner width/height: 1024/697 12:09:47 INFO - PROCESS | 22264 | __metrics 12:09:48 ERROR - PROCESS | 22264 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:09:48 INFO - PROCESS | 22264 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 12:09:49 INFO - TEST-INFO | 22264: exit 0 12:09:49 INFO - Browser initialized. 12:09:49 INFO - Running cycle 1/1 for kraken test... 12:09:49 INFO - TEST-INFO | started process 22346 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1hglan/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:10:01 INFO - PROCESS | 22346 | RSS: Main: 154247168 12:10:01 INFO - PROCESS | 22346 | 12:10:04 INFO - PROCESS | 22346 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59389/tests/kraken/driver.html?testName=audio-beat-detection) 12:10:04 INFO - PROCESS | 22346 | RSS: Main: 193826816 12:10:04 INFO - PROCESS | 22346 | 12:10:07 INFO - PROCESS | 22346 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59389/tests/kraken/driver.html?testName=audio-dft) 12:10:08 INFO - PROCESS | 22346 | RSS: Main: 183451648 12:10:08 INFO - PROCESS | 22346 | 12:10:11 INFO - PROCESS | 22346 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59389/tests/kraken/driver.html?testName=audio-fft) 12:10:11 INFO - PROCESS | 22346 | RSS: Main: 172109824 12:10:11 INFO - PROCESS | 22346 | 12:10:13 INFO - PROCESS | 22346 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59389/tests/kraken/driver.html?testName=audio-oscillator) 12:10:14 INFO - PROCESS | 22346 | RSS: Main: 173322240 12:10:14 INFO - PROCESS | 22346 | 12:10:16 INFO - PROCESS | 22346 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59389/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:10:17 INFO - PROCESS | 22346 | RSS: Main: 175026176 12:10:17 INFO - PROCESS | 22346 | 12:10:20 INFO - PROCESS | 22346 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59389/tests/kraken/driver.html?testName=imaging-darkroom) 12:10:20 INFO - PROCESS | 22346 | RSS: Main: 176472064 12:10:20 INFO - PROCESS | 22346 | 12:10:24 INFO - PROCESS | 22346 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59389/tests/kraken/driver.html?testName=imaging-desaturate) 12:10:24 INFO - PROCESS | 22346 | RSS: Main: 175071232 12:10:24 INFO - PROCESS | 22346 | 12:10:27 INFO - PROCESS | 22346 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59389/tests/kraken/driver.html?testName=json-parse-financial) 12:10:28 INFO - PROCESS | 22346 | RSS: Main: 177745920 12:10:28 INFO - PROCESS | 22346 | 12:10:30 INFO - PROCESS | 22346 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59389/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:10:30 INFO - PROCESS | 22346 | RSS: Main: 184340480 12:10:30 INFO - PROCESS | 22346 | 12:10:32 INFO - PROCESS | 22346 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59389/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:10:33 INFO - PROCESS | 22346 | RSS: Main: 181022720 12:10:33 INFO - PROCESS | 22346 | 12:10:35 INFO - PROCESS | 22346 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59389/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:10:35 INFO - PROCESS | 22346 | RSS: Main: 192811008 12:10:35 INFO - PROCESS | 22346 | 12:10:38 INFO - PROCESS | 22346 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:10:39 INFO - PROCESS | 22346 | RSS: Main: 195387392 12:10:39 INFO - PROCESS | 22346 | 12:10:41 INFO - PROCESS | 22346 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:10:42 INFO - PROCESS | 22346 | RSS: Main: 194547712 12:10:42 INFO - PROCESS | 22346 | 12:10:44 INFO - PROCESS | 22346 | Cycle 1(1): loaded http://localhost:59389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59389/tests/kraken/driver.html?testName=ai-astar) 12:10:44 INFO - PROCESS | 22346 | RSS: Main: 255074304 12:10:44 INFO - PROCESS | 22346 | 12:10:44 INFO - PROCESS | 22346 | __start_tp_report 12:10:44 INFO - PROCESS | 22346 | _x_x_mozilla_page_load 12:10:44 INFO - PROCESS | 22346 | _x_x_mozilla_page_load_details 12:10:44 INFO - PROCESS | 22346 | |i|pagename|runs| 12:10:44 INFO - PROCESS | 22346 | |0;ai-astar;111;116;107;115;115;113;102;113;113;114 12:10:44 INFO - PROCESS | 22346 | |1;audio-beat-detection;159;133;157;176;132;151;154;147;178;135 12:10:44 INFO - PROCESS | 22346 | |2;audio-dft;162;160;161;161;161;161;162;161;163;162 12:10:44 INFO - PROCESS | 22346 | |3;audio-fft;73;77;120;94;74;74;76;112;96;74 12:10:44 INFO - PROCESS | 22346 | |4;audio-oscillator;95;94;143;95;95;94;131;96;95;126 12:10:44 INFO - PROCESS | 22346 | |5;imaging-gaussian-blur;117;116;117;117;118;116;116;119;117;117 12:10:44 INFO - PROCESS | 22346 | |6;imaging-darkroom;146;147;146;146;147;147;146;147;147;146 12:10:44 INFO - PROCESS | 22346 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;96 12:10:44 INFO - PROCESS | 22346 | |8;json-parse-financial;66;67;66;66;68;67;65;74;65;64 12:10:44 INFO - PROCESS | 22346 | |9;json-stringify-tinderbox;70;71;71;71;70;71;71;71;70;70 12:10:44 INFO - PROCESS | 22346 | |10;stanford-crypto-aes;83;83;83;82;82;82;83;83;83;92 12:10:44 INFO - PROCESS | 22346 | |11;stanford-crypto-ccm;129;122;118;122;127;121;129;122;124;128 12:10:44 INFO - PROCESS | 22346 | |12;stanford-crypto-pbkdf2;140;135;148;153;147;137;153;148;148;150 12:10:44 INFO - PROCESS | 22346 | |13;stanford-crypto-sha256-iterative;70;72;69;69;69;69;71;69;70;69 12:10:44 INFO - PROCESS | 22346 | __end_tp_report 12:10:44 INFO - PROCESS | 22346 | __start_cc_report 12:10:44 INFO - PROCESS | 22346 | _x_x_mozilla_cycle_collect,1139 12:10:44 INFO - PROCESS | 22346 | __end_cc_report 12:10:44 INFO - PROCESS | 22346 | __startTimestamp1457727044364__endTimestamp 12:10:44 INFO - PROCESS | 22346 | 12:10:44 INFO - PROCESS | 22346 | ------- Summary: start ------- 12:10:44 INFO - PROCESS | 22346 | Number of tests: 14 12:10:44 INFO - PROCESS | 22346 | 12:10:44 INFO - PROCESS | 22346 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.50 stddev:4.31 (3.8%) stddev-sans-first:4.56 12:10:44 INFO - PROCESS | 22346 | Values: 111.0 116.0 107.0 115.0 115.0 113.0 102.0 113.0 113.0 114.0 12:10:44 INFO - PROCESS | 22346 | 12:10:44 INFO - PROCESS | 22346 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:155.50 stddev:16.35 (10.5%) stddev-sans-first:17.15 12:10:44 INFO - PROCESS | 22346 | Values: 159.0 133.0 157.0 176.0 132.0 151.0 154.0 147.0 178.0 135.0 12:10:44 INFO - PROCESS | 22346 | 12:10:44 INFO - PROCESS | 22346 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 12:10:44 INFO - PROCESS | 22346 | Values: 162.0 160.0 161.0 161.0 161.0 161.0 162.0 161.0 163.0 162.0 12:10:44 INFO - PROCESS | 22346 | 12:10:44 INFO - PROCESS | 22346 | [#3] audio-fft Cycles:10 Average:87.00 Median:75.00 stddev:17.54 (23.4%) stddev-sans-first:17.85 12:10:44 INFO - PROCESS | 22346 | Values: 73.0 77.0 120.0 94.0 74.0 74.0 76.0 112.0 96.0 74.0 12:10:44 INFO - PROCESS | 22346 | 12:10:44 INFO - PROCESS | 22346 | [#4] audio-oscillator Cycles:10 Average:106.40 Median:95.00 stddev:19.04 (20.0%) stddev-sans-first:19.75 12:10:44 INFO - PROCESS | 22346 | Values: 95.0 94.0 143.0 95.0 95.0 94.0 131.0 96.0 95.0 126.0 12:10:44 INFO - PROCESS | 22346 | 12:10:44 INFO - PROCESS | 22346 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.94 (0.8%) stddev-sans-first:1.00 12:10:44 INFO - PROCESS | 22346 | Values: 117.0 116.0 117.0 117.0 118.0 116.0 116.0 119.0 117.0 117.0 12:10:44 INFO - PROCESS | 22346 | 12:10:44 INFO - PROCESS | 22346 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 12:10:44 INFO - PROCESS | 22346 | Values: 146.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 147.0 146.0 12:10:44 INFO - PROCESS | 22346 | 12:10:44 INFO - PROCESS | 22346 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 12:10:44 INFO - PROCESS | 22346 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 12:10:44 INFO - PROCESS | 22346 | 12:10:44 INFO - PROCESS | 22346 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:66.50 stddev:2.78 (4.2%) stddev-sans-first:2.93 12:10:44 INFO - PROCESS | 22346 | Values: 66.0 67.0 66.0 66.0 68.0 67.0 65.0 74.0 65.0 64.0 12:10:44 INFO - PROCESS | 22346 | 12:10:44 INFO - PROCESS | 22346 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 12:10:44 INFO - PROCESS | 22346 | Values: 70.0 71.0 71.0 71.0 70.0 71.0 71.0 71.0 70.0 70.0 12:10:44 INFO - PROCESS | 22346 | 12:10:44 INFO - PROCESS | 22346 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:2.99 (3.6%) stddev-sans-first:3.16 12:10:44 INFO - PROCESS | 22346 | Values: 83.0 83.0 83.0 82.0 82.0 82.0 83.0 83.0 83.0 92.0 12:10:44 INFO - PROCESS | 22346 | 12:10:44 INFO - PROCESS | 22346 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:125.50 stddev:3.82 (3.0%) stddev-sans-first:3.64 12:10:44 INFO - PROCESS | 22346 | Values: 129.0 122.0 118.0 122.0 127.0 121.0 129.0 122.0 124.0 128.0 12:10:44 INFO - PROCESS | 22346 | 12:10:44 INFO - PROCESS | 22346 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.90 Median:148.00 stddev:6.37 (4.3%) stddev-sans-first:6.39 12:10:44 INFO - PROCESS | 22346 | Values: 140.0 135.0 148.0 153.0 147.0 137.0 153.0 148.0 148.0 150.0 12:10:44 INFO - PROCESS | 22346 | 12:10:44 INFO - PROCESS | 22346 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.50 stddev:1.06 (1.5%) stddev-sans-first:1.12 12:10:44 INFO - PROCESS | 22346 | Values: 70.0 72.0 69.0 69.0 69.0 69.0 71.0 69.0 70.0 69.0 12:10:44 INFO - PROCESS | 22346 | -------- Summary: end -------- 12:10:44 INFO - PROCESS | 22346 | 12:10:45 INFO - TEST-INFO | 22346: exit 0 12:10:45 INFO - TEST-OK | kraken | took 62279ms 12:10:45 INFO - SUITE-END | took 1179s 12:10:45 INFO - Completed test suite (00:19:39) 12:10:45 INFO - javascript benchmark 12:10:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2622.265765585636, 2669.799765017624, 2682.8926842926285, 2696.1372360844525, 2716.2801857507766, 4397.230484665187, 4502.819887204508, 4544.704594201375, 4552.704074235173, 4572.817087316512, 4554.658400619958, 4601.3558101865765, 4635.490096089427, 4639.721616703, 4697.835575754849, 4258.97870510647, 4275.166342563201, 4284.935725964113, 4285.250081235787, 4376.212281789277, 4130.710850240484, 4302.20409224293, 4330.350447432895, 4340.717853339539, 4352.325389564607, 4196.22369861575, 4234.91530169398, 4253.255680255943, 4280.0, 4302.225599392108, 4233.25917964355, 4235.174141042498, 4237.0466645004935, 4256.616904478581, 4271.63691086258, 4034.1729945361426, 4173.24881521326, 4214.831406743727, 4220.282551966173, 4260.573942605745, 4503.0, 4534.727916325031, 4554.8405805796965, 4564.2925346571, 4594.977025114887, 4903.779329930162, 4915.926261106087, 4917.4344950330815, 4927.137750893615, 4951.331570238044, 4779.330893674888, 4816.494268101834, 4930.3344048553345, 4947.554720075211, 5000.099982003274, 4528.682992190581, 4538.341940418653, 4542.659300552472, 4580.129775342708, 4591.540845915381, 4967.925481117786, 4980.950190498049, 4981.875453113628, 4983.476734942778, 5033.446320904697, 4712.575868171881, 4787.329773831666, 4816.277558366203, 4859.0, 4863.416390033148, 4906.239532872411, 4915.11527924977, 4926.236433352836, 4936.136176169156, 4960.875978100504, 4871.171900776805, 4875.366202393666, 4884.023195360942, 4884.12085824555, 4933.802647894044, 4693.037927224911, 4823.131836269435, 4880.6095512358925, 4904.313396124546, 4914.926276105862, 4127.422160897477, 4129.442525259052, 4131.669466442678, 4136.8138433770555, 4167.83328666856, 3629.8366573504254, 3641.235340578455, 3645.343838109166, 3662.9633703663153, 3681.815909204529, 4171.833126674899, 4217.135487225173, 4256.744595324229, 4295.248331541968, 4301.548337424525, 4913.754312284372, 4939.061578300111, 4948.054410634651, 4951.628627852925, 4960.652754307164, 4099.774512401847, 4222.725522841006, 4225.68307376948, 4228.6617070634275, 4263.531011588722, 4318.093200427946, 4376.3654270130655, 4377.321515165155, 4383.583559561836, 4416.646668266531, 4624.398828152319, 4634.420697412824, 4639.2113340731485, 4660.300954856799, 4698.7415692137265, 4868.634852386014, 4879.146149423766, 4897.142999974919, 4905.092557876804, 4909.558139767438, 4636.6058884995155, 4656.697314674535, 4660.976695116503, 4663.533646635309, 4712.858614241578, 4890.0, 4926.926096108489, 4930.531599498042, 4932.778024988956, 4938.950610493849, 4749.643776716829, 4895.8041678332465, 4958.231474121517, 5015.548600625962, 5041.1430056889685, 4769.761511924459, 4773.069251495925, 4790.329353890388, 4816.566509014206, 4839.830605928775, 4784.258439941815, 4786.2581299898575, 4795.520447955177, 4796.2805579163405, 4838.250071238964, 4502.3246513023305, 4694.2958556216845, 4706.458757242961, 4821.855344339676, 4828.889355448337, 4851.029794041277, 4868.440129385024, 4893.437254715611, 4895.265710143507, 4938.308636790924, 4790.401199850019, 4791.041791641616, 4791.448983366958, 4793.5685788279225, 4802.567768900815], "unit": "score", "name": "dojo.html", "value": 4520.222488957028}, {"lowerIsBetter": false, "replicates": [512.3569919750712, 515.7369741431874, 522.208853586816, 550.9256250406195, 550.980685731397, 32144.196395090104, 32778.0, 32899.177520562, 32986.835065824635, 33050.694930506936, 40214.7989260054, 41093.0, 41194.58805411945, 41302.0, 41331.38002929959, 7859.096203936563, 8006.639701213459, 8065.516069035877, 8068.838623227532, 8079.272865442109, 7879.369650427952, 7983.441159118864, 8016.559089250118, 8027.117017128111, 8028.157043510435, 7954.085280192794, 8052.718154864581, 8058.39562032847, 8058.516489010678, 8059.879101813477, 7930.682772689085, 7980.920190798134, 8006.079300880357, 8016.7194148204535, 8017.797330400428, 7916.722914697958, 8048.396370272195, 8052.59737013147, 8053.677852885878, 8055.516668999879, 38009.619903800885, 38575.614243857766, 38577.22845543102, 38618.80690596529, 38702.419463708065, 2939.1182645206354, 2976.419598178356, 2984.9850750746323, 3000.804947678394, 3108.5492603572357, 28462.0, 29072.27319317034, 29181.56227656587, 29354.197690112516, 29733.0, 3422.7775194612273, 3426.1605906552804, 3476.1830969722096, 3551.627079156703, 3568.6966607838367, 232215.0, 233254.0, 233282.0, 233297.0, 233304.0, 39279.607203928164, 54807.451925480236, 55118.17322740162, 55173.44826551683, 55173.72413137989, 36676.0, 36896.44655330172, 36910.26179476395, 36913.0, 36948.44577331342, 13014.609561713163, 13256.204627722367, 13287.933560332136, 13293.335333233494, 13299.534516291884, 10375.84436233457, 10423.061924426685, 10432.321899076536, 10433.16534677224, 10437.165026797838, 13176.143550669176, 13223.603291901258, 13645.795313070312, 13678.93160534191, 13765.0, 5452.945470545323, 5485.972570137204, 5534.75093620788, 5551.361593416728, 5606.607537472338, 858.7552547523926, 871.3900269811157, 886.1448702002598, 895.6909866096187, 906.551257127726, 26256.73743262543, 26902.0, 27153.456930861666, 27367.86316068447, 27549.86225068902, 802.8153524689354, 909.0727457992942, 991.3704797453669, 1020.7244044108049, 1080.5731735964407, 11951.335281920712, 13083.0, 13352.866471335357, 13393.598192054254, 13432.932835335761, 251412.0, 251880.0, 254654.0, 255318.0, 255969.0, 43467.130657386675, 43975.560244397784, 44024.55975440269, 44032.0, 44101.0, 1078.6817888722846, 1124.7469319403233, 1203.3501908969233, 1214.4899142360407, 1217.829503869459, 23824.642630360213, 24316.635250471612, 26737.33156671099, 27335.0, 27436.862815686593, 36960.445593315584, 36991.630083698816, 36994.26011479701, 37073.629263707015, 37151.62848371482, 170986.0, 173725.0, 173841.0, 173863.0, 224120.0, 28678.0, 29065.34954407369, 29102.70897291, 29116.563251551666, 29286.0, 33347.0, 33998.150046249044, 34521.82739086288, 34553.30893382169, 34909.65090349064, 29318.7068129316, 29732.0, 32126.0, 32159.196020099684, 32231.516527251642, 31961.68038319587, 32020.6797932027, 32172.19569510781, 32466.0, 32717.345653087283, 32156.03531894047, 32580.0, 32792.180195495304, 32997.34005319928, 33100.66899330976, 26313.605295920195, 28957.276068098465, 29024.854875725487, 29047.12858614245, 29124.563131553467, 23212.883935580216, 23295.41761455977, 23373.532529349657, 23543.764562354158, 23574.0], "unit": "score", "name": "ext.html", "value": 15931.170204520942}, {"lowerIsBetter": false, "replicates": [284.7807188464882, 324.81485553234666, 325.83870983862994, 327.3649120705832, 340.1954377896276, 14028.228447435387, 15280.84719152808, 15297.541073767778, 15816.525504234862, 15840.0, 13985.300734963263, 14145.929270353634, 14309.0, 14654.48709295175, 15755.527334179964, 5017.573506251963, 5177.068127737006, 5179.870503237412, 5193.402758682743, 5197.584193264549, 4917.7541122943885, 5040.269160971657, 5108.514691104339, 5109.131447653889, 5138.8715282118055, 5040.42035165957, 5065.949340506585, 5067.037262920052, 5084.84745457635, 5088.669236499616, 4915.016996600659, 5009.4239162496415, 5034.723090230036, 5035.144025515671, 5045.823396181135, 4478.373027776114, 4518.164139634146, 4520.977395113036, 4522.479914809774, 4524.61540769035, 18354.541136471562, 18431.539211519685, 18568.350107746162, 19214.711779323323, 19234.422967311002, 1845.2987864611362, 1881.3227238194238, 2356.8215892053972, 2421.0651497433137, 2467.679201703785, 11967.281963082156, 11988.160828741991, 12406.193597416139, 12561.685957851036, 12597.937010314981, 1750.9912450437666, 1810.4930619426582, 1817.0, 1824.6624374490762, 1839.8620103492292, 49736.25395619069, 52001.0, 52306.738466307805, 52452.47547524514, 52516.474835251924, 9393.0, 9969.202463802878, 10101.848472272775, 10158.0, 10216.131628811485, 12578.68553286157, 12712.872871271169, 12719.427625756864, 12723.936380318224, 12825.551105711254, 7058.0, 7133.928660713326, 7167.605781681953, 7242.9275707243305, 7288.3076107769675, 6882.621455819978, 7004.122698655986, 7077.469189810682, 7105.969634403086, 7165.3551180394015, 4241.575842415734, 4327.480702315742, 4340.348947657877, 4387.429634147604, 4406.405135306757, 1751.509577318353, 1763.647270545896, 1768.2219823277717, 1773.742807292961, 1774.157275294225, 756.5763172623349, 878.8901387326584, 899.9145081217274, 950.6862735297335, 978.8433850583872, 14639.560813175622, 14686.118832870063, 14810.555683329518, 15183.392664293304, 15768.92115539415, 806.749907528668, 813.8616435206029, 825.8761185822175, 847.6651722569551, 858.9484630922165, 8957.193852553302, 9054.502002389932, 9184.540772961325, 9210.35527513081, 9339.579718912666, 344040.0, 349353.0, 350474.0, 357452.0, 369404.0, 61779.0, 62326.37673623297, 62556.37443625506, 62772.0, 63323.683381583716, 754.8980887580107, 761.1399118995499, 778.4356341652257, 778.9922100779033, 779.7738655789757, 13664.521741738992, 13955.0, 14195.574132776033, 14283.143011419348, 14360.640983975483, 28698.56952145678, 29027.56458653164, 29828.552571711876, 30185.69814301829, 30403.087907362813, 36456.08859778527, 37461.62538374581, 37519.24961500809, 37778.62221377861, 37833.62166378411, 6869.656517174021, 6931.89602155958, 6997.755078572225, 7099.361057504642, 7214.567125972459, 8498.915010849812, 10286.177105831664, 10390.792184156124, 10456.111230545488, 10662.200334974752, 8957.686480973134, 9180.954095229481, 9235.26117910579, 9259.398139120936, 9364.157225849434, 8964.372493925363, 9173.220276276325, 9212.723618291462, 9257.677689376162, 9471.384360016576, 9220.44677319363, 9530.332876698565, 9696.321257511907, 9701.126898579161, 9804.803903922024, 6721.655668866344, 7018.543794653331, 7021.017057611836, 7128.108986376703, 7146.428285737024, 7338.669759860926, 8888.77778055528, 9284.442933424016, 9418.81162376735, 9572.042795720372], "unit": "score", "name": "jquery.html", "value": 7589.325151539912}, {"lowerIsBetter": false, "replicates": [1232.0451649971276, 1378.1042322490382, 1379.6895698467847, 1509.3962415033984, 1737.6437830244802, 7152.1417429908415, 7269.3457588817, 7272.090988626422, 7277.781666550005, 7303.525270857391, 7100.502964792467, 7270.709171633128, 7286.489945703803, 7288.307610776981, 7296.890546641805, 1799.7300404939233, 1850.69463538516, 1853.6756067688168, 2098.485870961613, 2126.5959467701164, 2095.7275554177936, 2132.4882028313173, 2146.838987075968, 2148.376970678509, 2149.849510534263, 2079.085202510898, 2112.1551379448265, 2121.1621409543222, 2121.649927761925, 2153.7953894380007, 2128.31893793986, 2135.508832968426, 2136.797004284598, 2141.4111119442277, 2141.6145093883174, 2052.1688716070016, 2143.121320258702, 2145.978540214609, 2146.409737322249, 2146.7960543748477, 7414.59219742914, 7452.552846829208, 7455.4408419368765, 7456.291652293077, 7468.439867009996, 4199.68502362321, 4272.4445822042935, 4297.699161058727, 4302.075053863403, 4313.892152696177, 2741.4105967217142, 2783.9304017399522, 2882.7405533502088, 2883.7548808351316, 2884.120343295294, 888.595688961521, 905.1039470923804, 906.7551761024487, 910.4446287764458, 937.7983733497263, 10119.645812396604, 10128.240381971382, 10154.695359139163, 10202.183825293958, 10203.846942295871, 3942.901427464279, 4096.836126554964, 4171.0, 4190.622843943998, 4190.622843944059, 8587.699430519902, 8634.827303454022, 8647.26498247656, 8656.697015604424, 8658.567071646392, 4440.0, 4443.244648409714, 4443.666724995638, 4445.666575006888, 4448.35498852671, 3281.343731253759, 3751.5685696144747, 3842.0, 3989.261986532501, 3992.381180916904, 3406.114410253352, 3406.2335974406055, 3408.9829550852087, 3466.4973578830927, 3508.649135086471, 1072.570971611346, 1083.06315037492, 1094.4308959341258, 1099.1646348774989, 1101.3557069114659, 943.556528431636, 949.8955114937352, 959.5490119643756, 995.2088089968493, 1212.5755985405215, 7033.050538177383, 7045.7533986311255, 7050.541714788523, 7072.434205263567, 7079.150501939697, 439.49238629383115, 444.7042716593494, 456.3474231848422, 457.04249597094037, 457.49903855278416, 5351.357837059578, 5356.7857285708915, 5374.811881584125, 5380.408155102936, 5412.648177868426, 8369.288610468178, 8455.830883382421, 8487.278581320534, 8588.957055214683, 8685.739427817049, 8465.619047142893, 8522.659093636184, 8525.232729054414, 8535.53054582004, 8563.272121869712, 6968.860622787516, 7021.508494405342, 7169.318914703095, 7183.89224161638, 7232.855342893218, 6837.0, 6866.622335771581, 6871.793846184622, 6872.793816185523, 6872.828179295558, 8044.436889417684, 8133.024037115584, 8143.022837259567, 8163.306118979954, 8267.917320826955, 7774.844503110019, 7965.522068675898, 8046.074701409413, 8054.476459030145, 8067.636956336862, 6395.488360931021, 6469.5794773339585, 6501.3823686751575, 6522.673866306571, 6525.673716314071, 7060.576365418091, 7064.82337941535, 7104.076470058859, 7123.038389817309, 7128.358447739728, 6309.747610095545, 6392.360763923571, 6484.935150648433, 6517.315681853527, 6554.573952693059, 6092.329843717099, 6450.548461607643, 6476.093346931528, 6546.345365463416, 6575.408213260829, 6382.648954307558, 6428.903566446601, 6443.323451037573, 6444.613323200623, 6451.774187903588, 5976.103584462366, 5983.072623743326, 5989.3112292085225, 6072.72672729737, 6137.294211165595, 6020.548458865515, 6062.605930614496, 6070.0591408331775, 6083.391660833881, 6100.511959043355], "unit": "score", "name": "mootools.html", "value": 4086.740316458197}, {"lowerIsBetter": false, "replicates": [302.82436187011524, 304.65573901491314, 305.770671996003, 313.5375321400934, 314.7371944426404, 5201.843944681661, 5258.158694608864, 5269.130593452081, 5331.067063263933, 5406.756695948682, 5255.264263003182, 5319.414864364927, 5341.599380046493, 5343.492368225013, 5359.222912677669, 3891.6886649068006, 3953.5058117735284, 4033.838646454138, 4096.774677392742, 4118.6499147572495, 4058.1883623275316, 4082.4284600156, 4084.5098588169462, 4089.284375234337, 4094.2425651254466, 4028.5769994150633, 4045.5954404559457, 4050.9392359114636, 4055.5944405559503, 4061.3501839705655, 3825.1393436476847, 3984.1234928315725, 4076.673866090706, 4081.673466122733, 4082.4488694026522, 3529.8411571479087, 3542.5394698689265, 3542.7697199682198, 3557.4485954677066, 3559.7330200235087, 5148.382194136728, 5148.536631703165, 5155.819546315861, 5158.200478925773, 5161.638685292031, 4666.323383109464, 4679.789409476582, 4680.695754775928, 4680.882977925545, 4683.625309975194, 5578.553715702734, 5581.916271255935, 5583.330000399978, 5586.832395028156, 5586.91619625706, 3861.498005259298, 3864.0726225705907, 3864.478295430109, 3865.8260378283044, 3867.5552311484257, 5588.189712491666, 5837.620554663933, 5846.50304724099, 5850.795222167247, 5855.121731740231, 3918.1771827915886, 3935.4293627423863, 3939.113699417608, 3943.211357728466, 3943.921121577552, 4000.419939108871, 4005.399190121505, 4007.458993035961, 4008.8596899108393, 4009.859654912064, 4622.19111655459, 4624.838130665411, 4626.791794369262, 4628.884277893079, 4634.49378951842, 5537.667739935617, 5584.86037849057, 5589.74846131925, 5592.077307244341, 5603.075492543766, 1386.7850483175123, 1420.2756594137065, 1420.82239720035, 1421.8435972043067, 1423.5302350224401, 904.5477261369315, 932.1051790281406, 936.7049379445452, 945.1257586732245, 966.0, 4855.732934688555, 4870.829520966749, 4876.097921884463, 4889.755512224375, 4889.804407823718, 5770.884582308414, 5772.134179873053, 5773.278340207474, 5781.71091445426, 5797.594168408171, 4826.493218212107, 4860.659753817199, 4861.465238823726, 4869.220924652039, 4869.805207791649, 3084.892028779027, 3106.4563701352627, 3108.518179682153, 3111.284404586958, 3111.471049921519, 5432.538234250054, 5440.319960004999, 5443.564514838803, 5446.727663616883, 5457.590680698963, 5680.801171958961, 5890.9410905891245, 5918.526517878559, 5927.614705044159, 5931.051031834886, 5402.108652072443, 5421.26812880264, 5430.755615997289, 5432.7555260012605, 5434.266374039454, 5740.311162660508, 5744.195812586325, 5747.396523364986, 5750.539956803529, 5757.309122905278, 5633.408492108433, 5647.3787883333625, 5648.322201335866, 5649.0, 5651.180578816131, 5415.323084614423, 5415.458454154553, 5420.457954204548, 5422.918656220081, 5427.48438898304, 3802.16352402471, 3915.7063220259165, 3924.117073658404, 3928.9607103928593, 3963.4253033310583, 5515.0348688978465, 5668.51817595509, 5688.175214593944, 5757.165211044291, 5759.452851979056, 5405.837824865261, 5502.174673798962, 5513.889722205453, 5516.889662206813, 5531.751071201886, 5594.720263986703, 5597.412271711574, 5599.440055994368, 5607.495325420732, 5609.74756135983, 5463.399026107046, 5487.807926722546, 5491.478309560585, 5494.175873618829, 5495.203195536705, 5639.971800140973, 5644.0, 5645.435456454322, 5645.633033852787, 5648.23748793924, 5279.392869819866, 5446.046941785251, 5450.945490545044, 5451.863703407288, 5487.780488780404], "unit": "score", "name": "prototype.html", "value": 4163.123632907382}, {"lowerIsBetter": false, "replicates": [567.5884983387042, 594.4768603628806, 651.094977980607, 673.1484671890058, 682.1575354437269, 10467.424291663956, 10584.841227381596, 10588.894111058888, 10625.309354891926, 10659.0, 11235.438228088604, 11309.943450282737, 11323.094152467804, 11335.37655428951, 11350.148738844578, 600.8017354273079, 773.736929443989, 783.3733013589134, 794.9682012719484, 798.2376830127215, 791.2680770287461, 793.1513280789558, 795.4908858330673, 795.8885755994165, 797.1868693932186, 834.1283358889974, 836.0469065265602, 837.0081453477618, 837.3301358912845, 837.4556538250156, 631.0376675569747, 814.5031530766257, 828.6395417993192, 830.2901019628251, 830.7092517618815, 613.0467123622765, 613.4846728747829, 613.6348872420903, 614.1586027142798, 614.9938500614982, 11606.36165010924, 11645.767084658344, 11654.359010254433, 11679.065674746, 11688.883111168865, 10390.324628899098, 11050.668479945614, 11076.833847492295, 11236.269642473295, 11307.547698092067, 8898.86651700225, 9044.54777261141, 9073.7277881663, 9313.394629349139, 9392.013838546922, 3132.1699749566383, 3134.717875391203, 3174.1271150433818, 3180.0459862041293, 3219.307848812493, 39745.0, 40759.796201019104, 41020.974475638046, 41180.588194117976, 41361.0, 8854.955725221462, 8979.820403591892, 9014.0, 9076.31927605419, 9185.678501252423, 16385.50843474698, 16398.344066237456, 16409.179541022902, 16413.343466261456, 16460.506184814476, 6033.215681961317, 6183.0, 6351.460125889259, 6391.265004524446, 6543.869122617521, 3383.8477268522483, 3399.5920489541413, 3418.81196534193, 3443.1908501502126, 3450.344434557426, 2768.612394264764, 2822.618946442204, 2825.788065895066, 2831.66020077592, 2832.3910359272854, 428.91207302502914, 484.69706433479075, 509.5745052880812, 511.34292434221845, 530.1941049604579, 456.8766433063054, 490.4188536584159, 514.4803748214256, 518.3391176250236, 531.1952392125933, 6736.7642132525125, 6811.829704257433, 6832.965835170892, 6993.090898183305, 7043.260457651975, 527.4725274725274, 533.981310654133, 536.704812353212, 540.0899484368852, 542.4494138449477, 3336.6830151136087, 3356.848941797625, 3396.745244106702, 3404.5063465797816, 3459.377312083849, 48667.513324867, 48810.755946220044, 49386.0, 49405.75297123491, 49451.0, 42004.78997604993, 42876.0, 43192.784036080244, 43215.567844321784, 43356.56643433588, 39102.41346379807, 39444.0, 39549.80225098856, 39869.60130398717, 40060.799696001915, 7030.753923612649, 7244.927550724426, 7295.635218239173, 7342.632868356668, 7348.191698913222, 30461.23846903845, 30778.692213077582, 31770.0, 31803.68196318007, 31819.04542863718, 35432.0, 36702.265954681294, 38115.80942095272, 39445.60554394419, 39503.20993580055, 8332.50004999702, 8556.700515481929, 8600.78498037554, 8640.438371505832, 8645.567721613768, 9334.486603236886, 9385.765355866159, 9486.810263794547, 9575.808483830424, 9599.520023998912, 7773.37812974972, 8688.43608150539, 8994.955025224832, 9213.631454741735, 9380.906190938003, 9342.95328523353, 9495.572699228689, 9495.810083798424, 9594.376365536218, 9715.514224288616, 9721.805563888824, 9798.461084640414, 9988.800223995335, 10012.499375031364, 10133.594656213669, 8686.565671716262, 8689.348298877736, 8702.129787021247, 8707.608157632794, 8709.303255739398, 8764.0, 9195.126462986005, 9214.953925230599, 9235.492047937429, 9317.39436936597], "unit": "score", "name": "yui.html", "value": 5439.179710500436}], "name": "dromaeo_css", "value": 6081.310115271626}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 116.0, 107.0, 115.0, 115.0, 113.0, 102.0, 113.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [159.0, 133.0, 157.0, 176.0, 132.0, 151.0, 154.0, 147.0, 178.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 152.2}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 120.0, 94.0, 74.0, 74.0, 76.0, 112.0, 96.0, 74.0], "unit": "score", "name": "audio-fft", "value": 87.0}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 143.0, 95.0, 95.0, 94.0, 131.0, 96.0, 95.0, 126.0], "unit": "score", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 117.0, 118.0, 116.0, 116.0, 119.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 66.0, 68.0, 67.0, 65.0, 74.0, 65.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 66.8}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 71.0, 70.0, 71.0, 71.0, 71.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.6}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 82.0, 82.0, 82.0, 83.0, 83.0, 83.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [129.0, 122.0, 118.0, 122.0, 127.0, 121.0, 129.0, 122.0, 124.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [140.0, 135.0, 148.0, 153.0, 147.0, 137.0, 153.0, 148.0, 148.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.9}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 69.0, 69.0, 69.0, 69.0, 71.0, 69.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1539.2}]} 12:10:45 INFO - Return code: 0 12:10:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:10:45 ERROR - # TBPL SUCCESS # 12:10:45 INFO - Running post-action listener: _resource_record_post_action 12:10:45 INFO - Running post-run listener: _resource_record_post_run 12:10:46 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 528605184; Read time: 0; Write time: 511384 12:10:46 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 241393664; Read time: 0; Write time: 298100 12:10:46 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 287211520; Read time: 0; Write time: 213284 12:10:46 INFO - Running post-run listener: _upload_blobber_files 12:10:46 INFO - Blob upload gear active. 12:10:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:10:46 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 12:10:46 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'] 12:10:46 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 12:10:47 INFO - (blobuploader) - INFO - Open directory for files ... 12:10:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:10:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:10:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:47 INFO - (blobuploader) - INFO - Done attempting. 12:10:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:10:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:10:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:48 INFO - (blobuploader) - INFO - Done attempting. 12:10:48 INFO - (blobuploader) - INFO - Iteration through files over. 12:10:48 INFO - Return code: 0 12:10:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:10:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:10:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/706bb1e76ff6c77d1af2fa1f316f6fa6a9420942833a4bf49e7b2be5ff678d4e128f9fd04fef1846ad32189040a396173450b7f523e94835643dd4a5dcae0c53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b812ce686e50b4f7f1d2f2b50c72e14a88012f3fed99cc812d1415eb7d540b3cdb1609ce42f985000553a0dcd0723ebd1131e4aa245117ee5c2614ced87d4e7b"} 12:10:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:10:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:10:48 INFO - Contents: 12:10:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/706bb1e76ff6c77d1af2fa1f316f6fa6a9420942833a4bf49e7b2be5ff678d4e128f9fd04fef1846ad32189040a396173450b7f523e94835643dd4a5dcae0c53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b812ce686e50b4f7f1d2f2b50c72e14a88012f3fed99cc812d1415eb7d540b3cdb1609ce42f985000553a0dcd0723ebd1131e4aa245117ee5c2614ced87d4e7b"} 12:10:48 INFO - Running post-run listener: copy_logs_to_upload_dir 12:10:48 INFO - Copying logs to upload dir... 12:10:48 INFO - mkdir: /builds/slave/test/build/upload/logs 12:10:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.426509 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-11 12:10:48.416600) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 12:10:48.420423) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/706bb1e76ff6c77d1af2fa1f316f6fa6a9420942833a4bf49e7b2be5ff678d4e128f9fd04fef1846ad32189040a396173450b7f523e94835643dd4a5dcae0c53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b812ce686e50b4f7f1d2f2b50c72e14a88012f3fed99cc812d1415eb7d540b3cdb1609ce42f985000553a0dcd0723ebd1131e4aa245117ee5c2614ced87d4e7b"} build_url:https://queue.taskcluster.net/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011356 build_url: 'https://queue.taskcluster.net/v1/task/J6PxBkv9QIy6hFF-Vz-qBQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/706bb1e76ff6c77d1af2fa1f316f6fa6a9420942833a4bf49e7b2be5ff678d4e128f9fd04fef1846ad32189040a396173450b7f523e94835643dd4a5dcae0c53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b812ce686e50b4f7f1d2f2b50c72e14a88012f3fed99cc812d1415eb7d540b3cdb1609ce42f985000553a0dcd0723ebd1131e4aa245117ee5c2614ced87d4e7b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 12:10:48.445535) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:10:48.445867) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457725812.256726-35760389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004690 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 12:10:48.528587) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 12:10:48.528916) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 12:10:48.529242) ========= ========= Total master_lag: 0.28 =========