builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1457566263.64 results: success (0) buildid: 20160309145822 builduid: 38cc9e4fda5d446ca6d81c2ac717a54e revision: 9643098c3d8468e9fd60981ea207fa8a3d03c1ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:03.643677) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:03.644089) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:03.644411) ========= 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=cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006112 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:03.672773) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:03.673083) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:03.696583) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:03.696926) ========= 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=cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:03.754358) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:03.754665) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:03.755030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:03.755334) ========= 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=cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-09 15:31:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-03-09 15:31:05 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.420607 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:04.188689) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:04.189033) ========= 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=cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020294 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:04.238765) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:04.239156) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9643098c3d8468e9fd60981ea207fa8a3d03c1ec --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 9643098c3d8468e9fd60981ea207fa8a3d03c1ec --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=cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-09 15:31:05,393 truncating revision to first 12 chars 2016-03-09 15:31:05,393 Setting DEBUG logging. 2016-03-09 15:31:05,394 attempt 1/10 2016-03-09 15:31:05,394 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9643098c3d84?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-09 15:31:05,642 unpacking tar archive at: fx-team-9643098c3d84/testing/mozharness/ program finished with exit code 0 elapsedTime=0.535635 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:04.787321) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:04.787757) ========= echo 9643098c3d8468e9fd60981ea207fa8a3d03c1ec in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9643098c3d8468e9fd60981ea207fa8a3d03c1ec'] 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=cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 9643098c3d8468e9fd60981ea207fa8a3d03c1ec program finished with exit code 0 elapsedTime=0.003619 script_repo_revision: '9643098c3d8468e9fd60981ea207fa8a3d03c1ec' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:04.837386) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:04.837725) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 15:31:04.847647) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-03-09 15:31:04.847956) ========= /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=cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:31:06 INFO - MultiFileLogger online at 20160309 15:31:06 in /builds/slave/test 15:31:06 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 15:31:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:31:06 INFO - {'append_to_log': False, 15:31:06 INFO - 'base_work_dir': '/builds/slave/test', 15:31:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:31:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:31:06 INFO - 'branch': 'Fx-Team-Non-PGO', 15:31:06 INFO - 'buildbot_json_path': 'buildprops.json', 15:31:06 INFO - 'config_files': ('talos/linux_config.py',), 15:31:06 INFO - 'default_actions': ('clobber', 15:31:06 INFO - 'read-buildbot-config', 15:31:06 INFO - 'download-and-extract', 15:31:06 INFO - 'populate-webroot', 15:31:06 INFO - 'create-virtualenv', 15:31:06 INFO - 'install', 15:31:06 INFO - 'run-tests'), 15:31:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:31:06 INFO - 'download_minidump_stackwalk': True, 15:31:06 INFO - 'download_symbols': 'ondemand', 15:31:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:31:06 INFO - 'tooltool.py': '/tools/tooltool.py', 15:31:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:31:06 INFO - '/tools/misc-python/virtualenv.py')}, 15:31:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:31:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:31:06 INFO - 'installer_path': 'installer.exe', 15:31:06 INFO - 'log_level': 'info', 15:31:06 INFO - 'log_name': 'talos', 15:31:06 INFO - 'log_to_console': True, 15:31:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:31:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:31:06 INFO - 'opt_config_files': (), 15:31:06 INFO - 'pip_index': False, 15:31:06 INFO - 'sps_profile': False, 15:31:06 INFO - 'sps_profile_interval': 0, 15:31:06 INFO - 'suite': 'dromaeojs', 15:31:06 INFO - 'system_bits': '32', 15:31:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:31:06 INFO - 'title': 'talos-linux64-ix-054', 15:31:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:31:06 INFO - 'use_talos_json': True, 15:31:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:31:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:31:06 INFO - 'work_dir': 'build'} 15:31:06 INFO - ##### 15:31:06 INFO - ##### Running clobber step. 15:31:06 INFO - ##### 15:31:06 INFO - Running pre-action listener: _resource_record_pre_action 15:31:06 INFO - Running main action method: clobber 15:31:06 INFO - rmtree: /builds/slave/test/build 15:31:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:31:06 INFO - Running post-action listener: _resource_record_post_action 15:31:06 INFO - ##### 15:31:06 INFO - ##### Running read-buildbot-config step. 15:31:06 INFO - ##### 15:31:06 INFO - Running pre-action listener: _resource_record_pre_action 15:31:06 INFO - Running main action method: read_buildbot_config 15:31:06 INFO - Using buildbot properties: 15:31:06 INFO - { 15:31:06 INFO - "project": "", 15:31:06 INFO - "product": "firefox", 15:31:06 INFO - "script_repo_revision": "production", 15:31:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:31:06 INFO - "repository": "", 15:31:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:31:06 INFO - "buildid": "20160309145822", 15:31:06 INFO - "pgo_build": "False", 15:31:06 INFO - "basedir": "/builds/slave/test", 15:31:06 INFO - "buildnumber": 2621, 15:31:06 INFO - "slavename": "talos-linux64-ix-054", 15:31:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:31:06 INFO - "platform": "ubuntu64_hw", 15:31:06 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:31:06 INFO - "branch": "fx-team", 15:31:06 INFO - "repo_path": "integration/fx-team", 15:31:06 INFO - "revision": "9643098c3d8468e9fd60981ea207fa8a3d03c1ec", 15:31:06 INFO - "stage_platform": "linux64", 15:31:06 INFO - "builduid": "38cc9e4fda5d446ca6d81c2ac717a54e", 15:31:06 INFO - "slavebuilddir": "test" 15:31:06 INFO - } 15:31:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:31:06 INFO - Running post-action listener: _resource_record_post_action 15:31:06 INFO - ##### 15:31:06 INFO - ##### Running download-and-extract step. 15:31:06 INFO - ##### 15:31:06 INFO - Running pre-action listener: _resource_record_pre_action 15:31:06 INFO - Running main action method: download_and_extract 15:31:06 INFO - mkdir: /builds/slave/test/build/tests 15:31:06 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')]} 15:31:06 INFO - https://queue.taskcluster.net/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:31:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:31:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:31:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/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 15:31:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/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 15:31:13 INFO - Downloaded 1361 bytes. 15:31:13 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:31:13 INFO - Using the following test package requirements: 15:31:13 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:31:13 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:31:13 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:31:13 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:13 INFO - u'jsshell-linux-x86_64.zip'], 15:31:13 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:31:13 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:31:13 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:31:13 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:31:13 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:31:13 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:31:13 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:13 INFO - https://queue.taskcluster.net/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:31:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:31:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:31:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/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 15:31:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/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 15:31:14 INFO - Downloaded 22091896 bytes. 15:31:14 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'] 15:31:14 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 15:31:15 INFO - Return code: 0 15:31:15 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 15:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:15 INFO - https://queue.taskcluster.net/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:31:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:31:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:31:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/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 15:31:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/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 15:31:21 INFO - Downloaded 22091896 bytes. 15:31:21 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'] 15:31:21 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 15:31:23 INFO - Return code: 0 15:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:23 INFO - https://queue.taskcluster.net/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:31:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:31:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:31:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/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 15:31:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/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 15:31:24 INFO - Downloaded 10845161 bytes. 15:31:24 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'] 15:31:24 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 15:31:24 INFO - Return code: 0 15:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:24 INFO - https://queue.taskcluster.net/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:31:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:31:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:31:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/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 15:31:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/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 15:31:29 INFO - Downloaded 54420287 bytes. 15:31:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:31:29 INFO - mkdir: /builds/slave/test/properties 15:31:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:31:29 INFO - Writing to file /builds/slave/test/properties/build_url 15:31:29 INFO - Contents: 15:31:29 INFO - build_url:https://queue.taskcluster.net/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:31:29 INFO - Running post-action listener: _resource_record_post_action 15:31:29 INFO - Running post-action listener: set_extra_try_arguments 15:31:29 INFO - ##### 15:31:29 INFO - ##### Running populate-webroot step. 15:31:29 INFO - ##### 15:31:29 INFO - Running pre-action listener: _resource_record_pre_action 15:31:29 INFO - Running main action method: populate_webroot 15:31:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:31:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:31:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:31:29 INFO - '--tppagecycles', 15:31:29 INFO - '7'], 15:31:29 INFO - 'tests': ['tsvgm']}}, 15:31:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:31:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:31:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:31:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:31:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:31:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:31:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:31:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:29 INFO - 'talos_options': ['--e10s'], 15:31:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:31:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:29 INFO - 'tests': ['damp', 'tps']}, 15:31:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:29 INFO - 'talos_options': ['--e10s'], 15:31:29 INFO - 'tests': ['damp', 'tps']}, 15:31:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:31:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:31:29 INFO - 'other': {'tests': ['a11yr', 15:31:29 INFO - 'ts_paint', 15:31:29 INFO - 'tpaint', 15:31:29 INFO - 'sessionrestore', 15:31:29 INFO - 'sessionrestore_no_auto_restore', 15:31:29 INFO - 'tabpaint']}, 15:31:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:31:29 INFO - 'tests': ['a11yr', 15:31:29 INFO - 'ts_paint', 15:31:29 INFO - 'tpaint', 15:31:29 INFO - 'sessionrestore', 15:31:29 INFO - 'sessionrestore_no_auto_restore', 15:31:29 INFO - 'tabpaint']}, 15:31:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:31:29 INFO - 'tests': ['a11yr', 15:31:29 INFO - 'ts_paint', 15:31:29 INFO - 'tpaint', 15:31:29 INFO - 'sessionrestore', 15:31:29 INFO - 'sessionrestore_no_auto_restore', 15:31:29 INFO - 'tabpaint']}, 15:31:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:31:29 INFO - 'tests': ['a11yr', 15:31:29 INFO - 'ts_paint', 15:31:29 INFO - 'tpaint', 15:31:29 INFO - 'sessionrestore', 15:31:29 INFO - 'sessionrestore_no_auto_restore', 15:31:29 INFO - 'tabpaint']}, 15:31:29 INFO - 'other_l64': {'tests': ['a11yr', 15:31:29 INFO - 'ts_paint', 15:31:29 INFO - 'tpaint', 15:31:29 INFO - 'sessionrestore', 15:31:29 INFO - 'sessionrestore_no_auto_restore', 15:31:29 INFO - 'tabpaint']}, 15:31:29 INFO - 'other_nol64': {'tests': ['a11yr', 15:31:29 INFO - 'ts_paint', 15:31:29 INFO - 'tpaint', 15:31:29 INFO - 'sessionrestore', 15:31:29 INFO - 'sessionrestore_no_auto_restore', 15:31:29 INFO - 'tabpaint']}, 15:31:29 INFO - 'svgr': {'tests': ['tsvgx', 15:31:29 INFO - 'tsvgr_opacity', 15:31:29 INFO - 'tart', 15:31:29 INFO - 'tscrollx', 15:31:29 INFO - 'cart']}, 15:31:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:31:29 INFO - 'tests': ['tsvgx', 15:31:29 INFO - 'tsvgr_opacity', 15:31:29 INFO - 'tart', 15:31:29 INFO - 'tscrollx', 15:31:29 INFO - 'cart']}, 15:31:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:29 INFO - 'tests': ['tp5o']}, 15:31:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:29 INFO - 'talos_options': ['--e10s'], 15:31:29 INFO - 'tests': ['tp5o']}, 15:31:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:29 INFO - 'talos_options': ['--xperf_path', 15:31:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:31:29 INFO - 'tests': ['tp5n']}, 15:31:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:29 INFO - 'talos_options': ['--e10s', 15:31:29 INFO - '--xperf_path', 15:31:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:31:29 INFO - 'tests': ['tp5n']}}, 15:31:29 INFO - 'talos.zip': {'path': '', 15:31:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:31:29 INFO - Running post-action listener: _resource_record_post_action 15:31:29 INFO - ##### 15:31:29 INFO - ##### Running create-virtualenv step. 15:31:29 INFO - ##### 15:31:29 INFO - Running pre-action listener: _resource_record_pre_action 15:31:29 INFO - Running main action method: create_virtualenv 15:31:29 INFO - Creating virtualenv /builds/slave/test/build/venv 15:31:29 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 15:31:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:31:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:31:29 INFO - Using real prefix '/usr' 15:31:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:31:30 INFO - Installing distribute.............................................................................................................................................................................................done. 15:31:32 INFO - Installing pip.................done. 15:31:32 INFO - Return code: 0 15:31:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:31: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')]} 15:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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')]} 15:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95a1fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618160>, '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 0x1619060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16194f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', '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 15:31: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', 'pip>=1.5'] in /builds/slave/test/build 15:31: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 pip>=1.5 15:31:32 INFO - Using env: {'DISPLAY': ':0', 15:31:32 INFO - 'HOME': '/home/cltbld', 15:31:32 INFO - 'LANG': 'en_US.UTF-8', 15:31:32 INFO - 'LANGUAGE': 'en_US:en', 15:31:32 INFO - 'LOGNAME': 'cltbld', 15:31:32 INFO - 'MAIL': '/var/mail/cltbld', 15:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:32 INFO - 'MOZ_NO_REMOTE': '1', 15:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:32 INFO - 'NO_EM_RESTART': '1', 15:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:32 INFO - 'PWD': '/builds/slave/test', 15:31:32 INFO - 'SHELL': '/bin/bash', 15:31:32 INFO - 'SHLVL': '1', 15:31:32 INFO - 'TERM': 'linux', 15:31:32 INFO - 'TMOUT': '86400', 15:31:32 INFO - 'USER': 'cltbld', 15:31:32 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', 15:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:32 INFO - '_': '/tools/buildbot/bin/python'} 15:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:32 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 15:31:32 INFO - Cleaning up... 15:31:32 INFO - Return code: 0 15:31:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:31: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')]} 15:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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')]} 15:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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', '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 0x7f95a1fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618160>, '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 0x1619060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16194f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', '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 15:31: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', 'psutil>=0.7.1'] in /builds/slave/test/build 15:31: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 psutil>=0.7.1 15:31:32 INFO - Using env: {'DISPLAY': ':0', 15:31:32 INFO - 'HOME': '/home/cltbld', 15:31:32 INFO - 'LANG': 'en_US.UTF-8', 15:31:32 INFO - 'LANGUAGE': 'en_US:en', 15:31:32 INFO - 'LOGNAME': 'cltbld', 15:31:32 INFO - 'MAIL': '/var/mail/cltbld', 15:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:32 INFO - 'MOZ_NO_REMOTE': '1', 15:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:32 INFO - 'NO_EM_RESTART': '1', 15:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:32 INFO - 'PWD': '/builds/slave/test', 15:31:32 INFO - 'SHELL': '/bin/bash', 15:31:32 INFO - 'SHLVL': '1', 15:31:32 INFO - 'TERM': 'linux', 15:31:32 INFO - 'TMOUT': '86400', 15:31:32 INFO - 'USER': 'cltbld', 15:31:32 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', 15:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:32 INFO - '_': '/tools/buildbot/bin/python'} 15:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:32 INFO - Downloading/unpacking psutil>=0.7.1 15:31: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 15:31: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 15:31: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 15:31: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 15:31: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 15:31: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 15:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:31:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:34 INFO - Installing collected packages: psutil 15:31:34 INFO - Running setup.py install for psutil 15:31:34 INFO - building 'psutil._psutil_linux' extension 15:31:34 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 15:31:34 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 15:31:34 INFO - building 'psutil._psutil_posix' extension 15:31:34 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 15:31:35 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 15:31:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:35 INFO - Successfully installed psutil 15:31:35 INFO - Cleaning up... 15:31:35 INFO - Return code: 0 15:31:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:31: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')]} 15:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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')]} 15:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:35 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 0x7f95a1fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618160>, '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 0x1619060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16194f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', '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 15:31:35 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 15:31:35 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 15:31:35 INFO - Using env: {'DISPLAY': ':0', 15:31:35 INFO - 'HOME': '/home/cltbld', 15:31:35 INFO - 'LANG': 'en_US.UTF-8', 15:31:35 INFO - 'LANGUAGE': 'en_US:en', 15:31:35 INFO - 'LOGNAME': 'cltbld', 15:31:35 INFO - 'MAIL': '/var/mail/cltbld', 15:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:35 INFO - 'MOZ_NO_REMOTE': '1', 15:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:35 INFO - 'NO_EM_RESTART': '1', 15:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:35 INFO - 'PWD': '/builds/slave/test', 15:31:35 INFO - 'SHELL': '/bin/bash', 15:31:35 INFO - 'SHLVL': '1', 15:31:35 INFO - 'TERM': 'linux', 15:31:35 INFO - 'TMOUT': '86400', 15:31:35 INFO - 'USER': 'cltbld', 15:31:35 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', 15:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:35 INFO - '_': '/tools/buildbot/bin/python'} 15:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:31: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 15:31: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 15:31: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 15:31: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 15:31: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 15:31: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 15:31:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:31:37 INFO - Installing collected packages: mozsystemmonitor 15:31:37 INFO - Running setup.py install for mozsystemmonitor 15:31:37 INFO - Successfully installed mozsystemmonitor 15:31:37 INFO - Cleaning up... 15:31:37 INFO - Return code: 0 15:31:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:31:37 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')]} 15:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:37 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')]} 15:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:37 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 0x7f95a1fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618160>, '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 0x1619060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16194f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', '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 15:31:37 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 15:31:37 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 15:31:37 INFO - Using env: {'DISPLAY': ':0', 15:31:37 INFO - 'HOME': '/home/cltbld', 15:31:37 INFO - 'LANG': 'en_US.UTF-8', 15:31:37 INFO - 'LANGUAGE': 'en_US:en', 15:31:37 INFO - 'LOGNAME': 'cltbld', 15:31:37 INFO - 'MAIL': '/var/mail/cltbld', 15:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:37 INFO - 'MOZ_NO_REMOTE': '1', 15:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:37 INFO - 'NO_EM_RESTART': '1', 15:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:37 INFO - 'PWD': '/builds/slave/test', 15:31:37 INFO - 'SHELL': '/bin/bash', 15:31:37 INFO - 'SHLVL': '1', 15:31:37 INFO - 'TERM': 'linux', 15:31:37 INFO - 'TMOUT': '86400', 15:31:37 INFO - 'USER': 'cltbld', 15:31:37 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', 15:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:37 INFO - '_': '/tools/buildbot/bin/python'} 15:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:37 INFO - Downloading/unpacking blobuploader==1.2.4 15:31:37 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 15:31:37 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 15:31:37 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 15:31:37 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 15:31:37 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 15:31:37 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 15:31:39 INFO - Downloading blobuploader-1.2.4.tar.gz 15:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:31:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:31:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:40 INFO - Downloading docopt-0.6.1.tar.gz 15:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:31:40 INFO - Installing collected packages: blobuploader, requests, docopt 15:31:40 INFO - Running setup.py install for blobuploader 15:31:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:31:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:31:40 INFO - Running setup.py install for requests 15:31:40 INFO - Running setup.py install for docopt 15:31:40 INFO - Successfully installed blobuploader requests docopt 15:31:40 INFO - Cleaning up... 15:31:40 INFO - Return code: 0 15:31:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:40 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')]} 15:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:40 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')]} 15:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:40 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 0x7f95a1fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618160>, '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 0x1619060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16194f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', '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 15:31:40 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 15:31:40 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 15:31:40 INFO - Using env: {'DISPLAY': ':0', 15:31:40 INFO - 'HOME': '/home/cltbld', 15:31:40 INFO - 'LANG': 'en_US.UTF-8', 15:31:40 INFO - 'LANGUAGE': 'en_US:en', 15:31:40 INFO - 'LOGNAME': 'cltbld', 15:31:40 INFO - 'MAIL': '/var/mail/cltbld', 15:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:40 INFO - 'MOZ_NO_REMOTE': '1', 15:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:40 INFO - 'NO_EM_RESTART': '1', 15:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:40 INFO - 'PWD': '/builds/slave/test', 15:31:40 INFO - 'SHELL': '/bin/bash', 15:31:40 INFO - 'SHLVL': '1', 15:31:40 INFO - 'TERM': 'linux', 15:31:40 INFO - 'TMOUT': '86400', 15:31:40 INFO - 'USER': 'cltbld', 15:31:40 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', 15:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:40 INFO - '_': '/tools/buildbot/bin/python'} 15:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:41 INFO - Running setup.py (path:/tmp/pip-wwdZe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:41 INFO - Running setup.py (path:/tmp/pip-IC2Boi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:41 INFO - Running setup.py (path:/tmp/pip-oBOU_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:41 INFO - Running setup.py (path:/tmp/pip-M4ZOYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:41 INFO - Running setup.py (path:/tmp/pip-dCTNeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:41 INFO - Running setup.py (path:/tmp/pip-ynpo2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:41 INFO - Running setup.py (path:/tmp/pip-HjvgJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:41 INFO - Running setup.py (path:/tmp/pip-TkwOKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:41 INFO - Running setup.py (path:/tmp/pip-1kE0OY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:41 INFO - Running setup.py (path:/tmp/pip-mvjOqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:41 INFO - Running setup.py (path:/tmp/pip-deOjZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:41 INFO - Running setup.py (path:/tmp/pip-wBlTGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:41 INFO - Running setup.py (path:/tmp/pip-KRlWcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:42 INFO - Running setup.py (path:/tmp/pip-xMETTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:42 INFO - Running setup.py (path:/tmp/pip-T5iFDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:42 INFO - Running setup.py (path:/tmp/pip-8jd_0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:42 INFO - Running setup.py (path:/tmp/pip-NAdvqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:31:42 INFO - Running setup.py install for manifestparser 15:31:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:31:42 INFO - Running setup.py install for mozcrash 15:31:42 INFO - Running setup.py install for mozdebug 15:31:42 INFO - Running setup.py install for mozdevice 15:31:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:31:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:31:42 INFO - Running setup.py install for mozfile 15:31:42 INFO - Running setup.py install for mozhttpd 15:31:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:31:42 INFO - Running setup.py install for mozinfo 15:31:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:31:43 INFO - Running setup.py install for mozInstall 15:31:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:31:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:31:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:31:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:31:43 INFO - Running setup.py install for mozleak 15:31:43 INFO - Running setup.py install for mozlog 15:31:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:31:43 INFO - Running setup.py install for moznetwork 15:31:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:31:43 INFO - Running setup.py install for mozprocess 15:31:43 INFO - Running setup.py install for mozprofile 15:31:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:31:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:31:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:31:43 INFO - Running setup.py install for mozrunner 15:31:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:31:43 INFO - Running setup.py install for mozscreenshot 15:31:43 INFO - Running setup.py install for moztest 15:31:43 INFO - Running setup.py install for mozversion 15:31:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:31:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:31:44 INFO - Cleaning up... 15:31:44 INFO - Return code: 0 15:31:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:44 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 0x7f95a1fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618160>, '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 0x1619060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16194f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', '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 15:31:44 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 15:31:44 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 15:31:44 INFO - Using env: {'DISPLAY': ':0', 15:31:44 INFO - 'HOME': '/home/cltbld', 15:31:44 INFO - 'LANG': 'en_US.UTF-8', 15:31:44 INFO - 'LANGUAGE': 'en_US:en', 15:31:44 INFO - 'LOGNAME': 'cltbld', 15:31:44 INFO - 'MAIL': '/var/mail/cltbld', 15:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:44 INFO - 'MOZ_NO_REMOTE': '1', 15:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:44 INFO - 'NO_EM_RESTART': '1', 15:31:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:44 INFO - 'PWD': '/builds/slave/test', 15:31:44 INFO - 'SHELL': '/bin/bash', 15:31:44 INFO - 'SHLVL': '1', 15:31:44 INFO - 'TERM': 'linux', 15:31:44 INFO - 'TMOUT': '86400', 15:31:44 INFO - 'USER': 'cltbld', 15:31:44 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', 15:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:44 INFO - '_': '/tools/buildbot/bin/python'} 15:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:44 INFO - Running setup.py (path:/tmp/pip-MFhaBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:44 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)) 15:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:44 INFO - Running setup.py (path:/tmp/pip-xqJ67F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:44 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)) 15:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:44 INFO - Running setup.py (path:/tmp/pip-FJw4qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:44 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)) 15:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:44 INFO - Running setup.py (path:/tmp/pip-8Bm9Y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:44 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)) 15:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:44 INFO - Running setup.py (path:/tmp/pip-ZYzuim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:44 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)) 15:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:44 INFO - Running setup.py (path:/tmp/pip-Do_fuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:44 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)) 15:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:44 INFO - Running setup.py (path:/tmp/pip-mg7MUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:44 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)) 15:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:44 INFO - Running setup.py (path:/tmp/pip-rVsr5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:44 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)) 15:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:44 INFO - Running setup.py (path:/tmp/pip-ssIcX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:44 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)) 15:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:44 INFO - Running setup.py (path:/tmp/pip-ClYlBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:45 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)) 15:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:45 INFO - Running setup.py (path:/tmp/pip-dXfpSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:45 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)) 15:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:45 INFO - Running setup.py (path:/tmp/pip-u2iFoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:45 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)) 15:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:45 INFO - Running setup.py (path:/tmp/pip-Qt8900-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:45 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)) 15:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:45 INFO - Running setup.py (path:/tmp/pip-fDzA2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:45 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)) 15:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:45 INFO - Running setup.py (path:/tmp/pip-L7XRPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:45 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)) 15:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:45 INFO - Running setup.py (path:/tmp/pip-hgWokp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:45 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)) 15:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:45 INFO - Running setup.py (path:/tmp/pip-0pKQWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:45 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)) 15:31:45 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)) 15:31:45 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)) 15:31:45 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)) 15:31:45 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)) 15:31:45 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)) 15:31:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:31: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 15:31: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 15:31: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 15:31: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 15:31: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 15:31: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 15:31:47 INFO - Downloading blessings-1.6.tar.gz 15:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:31:47 INFO - Installing collected packages: blessings 15:31:47 INFO - Running setup.py install for blessings 15:31:47 INFO - Successfully installed blessings 15:31:47 INFO - Cleaning up... 15:31:47 INFO - Return code: 0 15:31:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:31:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:47 INFO - Reading from file tmpfile_stdout 15:31:47 INFO - Current package versions: 15:31:47 INFO - argparse == 1.2.1 15:31:47 INFO - blessings == 1.6 15:31:47 INFO - blobuploader == 1.2.4 15:31:47 INFO - docopt == 0.6.1 15:31:47 INFO - manifestparser == 1.1 15:31:47 INFO - mozInstall == 1.12 15:31:47 INFO - mozcrash == 0.17 15:31:47 INFO - mozdebug == 0.1 15:31:47 INFO - mozdevice == 0.48 15:31:47 INFO - mozfile == 1.2 15:31:47 INFO - mozhttpd == 0.7 15:31:47 INFO - mozinfo == 0.9 15:31:47 INFO - mozleak == 0.1 15:31:47 INFO - mozlog == 3.1 15:31:47 INFO - moznetwork == 0.27 15:31:47 INFO - mozprocess == 0.22 15:31:47 INFO - mozprofile == 0.28 15:31:47 INFO - mozrunner == 6.11 15:31:47 INFO - mozscreenshot == 0.1 15:31:47 INFO - mozsystemmonitor == 0.0 15:31:47 INFO - moztest == 0.7 15:31:47 INFO - mozversion == 1.4 15:31:47 INFO - psutil == 3.1.1 15:31:47 INFO - requests == 1.2.3 15:31:47 INFO - wsgiref == 0.1.2 15:31:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:47 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')]} 15:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:47 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')]} 15:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:47 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 0x7f95a1fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618160>, '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 0x1619060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16194f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', '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 15:31:47 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 15:31:47 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 15:31:47 INFO - Using env: {'DISPLAY': ':0', 15:31:47 INFO - 'HOME': '/home/cltbld', 15:31:47 INFO - 'LANG': 'en_US.UTF-8', 15:31:47 INFO - 'LANGUAGE': 'en_US:en', 15:31:47 INFO - 'LOGNAME': 'cltbld', 15:31:47 INFO - 'MAIL': '/var/mail/cltbld', 15:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:47 INFO - 'MOZ_NO_REMOTE': '1', 15:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:47 INFO - 'NO_EM_RESTART': '1', 15:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:47 INFO - 'PWD': '/builds/slave/test', 15:31:47 INFO - 'SHELL': '/bin/bash', 15:31:47 INFO - 'SHLVL': '1', 15:31:47 INFO - 'TERM': 'linux', 15:31:47 INFO - 'TMOUT': '86400', 15:31:47 INFO - 'USER': 'cltbld', 15:31:47 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', 15:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:47 INFO - '_': '/tools/buildbot/bin/python'} 15:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:48 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)) 15:31:48 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)) 15:31:48 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)) 15:31:48 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)) 15:31:48 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)) 15:31:48 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)) 15:31:48 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)) 15:31:48 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)) 15:31:48 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)) 15:31:48 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)) 15:31:48 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)) 15:31:48 INFO - Cleaning up... 15:31:48 INFO - Return code: 0 15:31:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:31:48 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')]} 15:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:48 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')]} 15:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:48 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 0x7f95a1fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618160>, '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 0x1619060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16194f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', '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 15:31:48 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 15:31:48 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 15:31:48 INFO - Using env: {'DISPLAY': ':0', 15:31:48 INFO - 'HOME': '/home/cltbld', 15:31:48 INFO - 'LANG': 'en_US.UTF-8', 15:31:48 INFO - 'LANGUAGE': 'en_US:en', 15:31:48 INFO - 'LOGNAME': 'cltbld', 15:31:48 INFO - 'MAIL': '/var/mail/cltbld', 15:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:48 INFO - 'MOZ_NO_REMOTE': '1', 15:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:48 INFO - 'NO_EM_RESTART': '1', 15:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:48 INFO - 'PWD': '/builds/slave/test', 15:31:48 INFO - 'SHELL': '/bin/bash', 15:31:48 INFO - 'SHLVL': '1', 15:31:48 INFO - 'TERM': 'linux', 15:31:48 INFO - 'TMOUT': '86400', 15:31:48 INFO - 'USER': 'cltbld', 15:31:48 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', 15:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:48 INFO - '_': '/tools/buildbot/bin/python'} 15:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:48 INFO - Downloading/unpacking jsonschema 15:31: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 15:31: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 15:31: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 15:31: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 15:31: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 15:31: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 15:31:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:31:50 INFO - Downloading/unpacking functools32 (from jsonschema) 15:31:50 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 15:31:50 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 15:31:50 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 15:31:50 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 15:31:50 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 15:31:50 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 15:31:50 INFO - Downloading functools32-3.2.3-2.tar.gz 15:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:31:50 INFO - warning: no files found matching '*.txt' 15:31:50 INFO - no previously-included directories found matching 'build' 15:31:50 INFO - no previously-included directories found matching 'dist' 15:31:50 INFO - no previously-included directories found matching '.git*' 15:31:50 INFO - Installing collected packages: jsonschema, functools32 15:31:50 INFO - Running setup.py install for functools32 15:31:50 INFO - warning: no files found matching '*.txt' 15:31:50 INFO - no previously-included directories found matching 'build' 15:31:50 INFO - no previously-included directories found matching 'dist' 15:31:50 INFO - no previously-included directories found matching '.git*' 15:31:50 INFO - Successfully installed jsonschema functools32 15:31:50 INFO - Cleaning up... 15:31:50 INFO - Return code: 0 15:31:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:50 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 0x7f95a1fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1589410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1618160>, '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 0x1619060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16194f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', '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 15:31:50 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 15:31:50 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 15:31:50 INFO - Using env: {'DISPLAY': ':0', 15:31:50 INFO - 'HOME': '/home/cltbld', 15:31:50 INFO - 'LANG': 'en_US.UTF-8', 15:31:50 INFO - 'LANGUAGE': 'en_US:en', 15:31:50 INFO - 'LOGNAME': 'cltbld', 15:31:50 INFO - 'MAIL': '/var/mail/cltbld', 15:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:50 INFO - 'MOZ_NO_REMOTE': '1', 15:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:50 INFO - 'NO_EM_RESTART': '1', 15:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:50 INFO - 'PWD': '/builds/slave/test', 15:31:50 INFO - 'SHELL': '/bin/bash', 15:31:50 INFO - 'SHLVL': '1', 15:31:50 INFO - 'TERM': 'linux', 15:31:50 INFO - 'TMOUT': '86400', 15:31:50 INFO - 'USER': 'cltbld', 15:31:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', 15:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:50 INFO - '_': '/tools/buildbot/bin/python'} 15:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:50 INFO - Downloading/unpacking flake8 15:31:50 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 15:31:50 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 15:31:50 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 15:31:50 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 15:31:50 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 15:31:50 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 15:31:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:31:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:31:52 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 15:31:52 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 15:31:52 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 15:31:52 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 15:31:52 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 15:31:52 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 15:31:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:31:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:31:52 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 15:31:52 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 15:31:52 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 15:31:52 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 15:31:52 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 15:31:52 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 15:31:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:31:53 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 15:31:53 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 15:31:53 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 15:31:53 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 15:31:53 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 15:31:53 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 15:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:31:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:31:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:31:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:31:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:31:53 INFO - no previously-included directories found matching 'docs/_build' 15:31:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:31:53 INFO - Running setup.py install for pep8 15:31:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:31:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:31:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:31:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:31:53 INFO - no previously-included directories found matching 'docs/_build' 15:31:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:31:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:31:53 INFO - Cleaning up... 15:31:53 INFO - Return code: 0 15:31:53 INFO - Running post-action listener: _resource_record_post_action 15:31:53 INFO - Running post-action listener: _start_resource_monitoring 15:31:53 INFO - Starting resource monitoring. 15:31:53 INFO - ##### 15:31:53 INFO - ##### Running install step. 15:31:53 INFO - ##### 15:31:53 INFO - Running pre-action listener: _resource_record_pre_action 15:31:53 INFO - Running main action method: install 15:31:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:53 INFO - Reading from file tmpfile_stdout 15:31:53 INFO - Detecting whether we're running mozinstall >=1.0... 15:31:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:31:53 INFO - Reading from file tmpfile_stdout 15:31:53 INFO - Output received: 15:31:53 INFO - Usage: mozinstall [options] installer 15:31:53 INFO - Options: 15:31:53 INFO - -h, --help show this help message and exit 15:31:53 INFO - -d DEST, --destination=DEST 15:31:53 INFO - Directory to install application into. [default: 15:31:53 INFO - "/builds/slave/test"] 15:31:53 INFO - --app=APP Application being installed. [default: firefox] 15:31:53 INFO - mkdir: /builds/slave/test/build/application 15:31:53 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'] 15:31:53 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 15:32:09 INFO - Reading from file tmpfile_stdout 15:32:09 INFO - Output received: 15:32:09 INFO - /builds/slave/test/build/application/firefox/firefox 15:32:09 INFO - Running post-action listener: _resource_record_post_action 15:32:09 INFO - ##### 15:32:09 INFO - ##### Running run-tests step. 15:32:09 INFO - ##### 15:32:09 INFO - Running pre-action listener: _resource_record_pre_action 15:32:09 INFO - Running main action method: run_tests 15:32:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:32:09 INFO - Python 2.7.3 15:32:09 INFO - Return code: 0 15:32:09 INFO - grabbing minidump binary from tooltool 15:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:09 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 0x1618160>, '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 0x1619060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16194f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:32:09 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 15:32:09 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 15:32:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:32:09 INFO - Return code: 0 15:32:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:32:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:32:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:32:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:32:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:32:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:32:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:32:10 INFO - Return code: 0 15:32:10 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/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 15:32:10 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/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 15:32:10 INFO - Using env: {'DISPLAY': ':0', 15:32:10 INFO - 'HOME': '/home/cltbld', 15:32:10 INFO - 'LANG': 'en_US.UTF-8', 15:32:10 INFO - 'LANGUAGE': 'en_US:en', 15:32:10 INFO - 'LOGNAME': 'cltbld', 15:32:10 INFO - 'MAIL': '/var/mail/cltbld', 15:32:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:32:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:10 INFO - 'MOZ_NO_REMOTE': '1', 15:32:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:10 INFO - 'NO_EM_RESTART': '1', 15:32:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:10 INFO - 'PWD': '/builds/slave/test', 15:32:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:32:10 INFO - 'SHELL': '/bin/bash', 15:32:10 INFO - 'SHLVL': '1', 15:32:10 INFO - 'TERM': 'linux', 15:32:10 INFO - 'TMOUT': '86400', 15:32:10 INFO - 'USER': 'cltbld', 15:32:10 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859', 15:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:10 INFO - '_': '/tools/buildbot/bin/python'} 15:32:10 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/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 15:32:10 INFO - mozversion application_buildid: 20160309145822 15:32:10 INFO - mozversion application_changeset: 9643098c3d8468e9fd60981ea207fa8a3d03c1ec 15:32:10 INFO - mozversion application_display_name: Nightly 15:32:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:32:10 INFO - mozversion application_name: Firefox 15:32:10 INFO - mozversion application_remotingname: firefox 15:32:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:32:10 INFO - mozversion application_vendor: Mozilla 15:32:10 INFO - mozversion application_version: 48.0a1 15:32:10 INFO - mozversion platform_buildid: 20160309145822 15:32:10 INFO - mozversion platform_changeset: 9643098c3d8468e9fd60981ea207fa8a3d03c1ec 15:32:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:32:10 INFO - mozversion platform_version: 48.0a1 15:32:10 INFO - using testdate: 1457566330 15:32:10 INFO - actual date: 1457566330 15:32:10 INFO - starting webserver on 'localhost:35389' 15:32:10 INFO - SUITE-START | Running 2 tests 15:32:10 INFO - TEST-START | dromaeo_css 15:32:10 INFO - operating with platform_type : linux_ 15:32:10 INFO - Initialising browser for dromaeo_css test... 15:32:10 INFO - TEST-INFO | started process 21125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphH9Tar/profile http://localhost:35389/getInfo.html) 15:32:15 INFO - PROCESS | 21125 | __metrics Screen width/height:1600/1200 15:32:15 INFO - PROCESS | 21125 | colorDepth:24 15:32:15 INFO - PROCESS | 21125 | Browser inner width/height: 1024/697 15:32:15 INFO - PROCESS | 21125 | __metrics 15:32:16 ERROR - PROCESS | 21125 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:32:17 INFO - TEST-INFO | 21125: exit 0 15:32:17 INFO - Browser initialized. 15:32:17 INFO - Running cycle 1/1 for dromaeo_css test... 15:32:17 INFO - TEST-INFO | started process 21217 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphH9Tar/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:32:29 INFO - PROCESS | 21217 | RSS: Main: 153436160 15:32:29 INFO - PROCESS | 21217 | 15:33:20 INFO - PROCESS | 21217 | 1457566400533 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] 15:35:31 INFO - PROCESS | 21217 | Cycle 1(1): loaded http://localhost:35389/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35389/tests/dromaeo/cssquery-ext.html) 15:35:32 INFO - PROCESS | 21217 | RSS: Main: 235925504 15:35:32 INFO - PROCESS | 21217 | 15:38:35 INFO - PROCESS | 21217 | Cycle 1(1): loaded http://localhost:35389/tests/dromaeo/cssquery-ext.html (next: http://localhost:35389/tests/dromaeo/cssquery-jquery.html) 15:38:35 INFO - PROCESS | 21217 | RSS: Main: 233943040 15:38:35 INFO - PROCESS | 21217 | 15:41:37 INFO - PROCESS | 21217 | Cycle 1(1): loaded http://localhost:35389/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35389/tests/dromaeo/cssquery-mootools.html) 15:41:38 INFO - PROCESS | 21217 | RSS: Main: 233086976 15:41:38 INFO - PROCESS | 21217 | 15:44:40 INFO - PROCESS | 21217 | Cycle 1(1): loaded http://localhost:35389/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35389/tests/dromaeo/cssquery-prototype.html) 15:44:40 INFO - PROCESS | 21217 | RSS: Main: 225574912 15:44:40 INFO - PROCESS | 21217 | 15:47:43 INFO - PROCESS | 21217 | Cycle 1(1): loaded http://localhost:35389/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35389/tests/dromaeo/cssquery-yui.html) 15:47:44 INFO - PROCESS | 21217 | RSS: Main: 200204288 15:47:44 INFO - PROCESS | 21217 | 15:50:46 INFO - PROCESS | 21217 | Cycle 1(1): loaded http://localhost:35389/tests/dromaeo/cssquery-yui.html (next: http://localhost:35389/tests/dromaeo/cssquery-dojo.html) 15:50:46 INFO - PROCESS | 21217 | RSS: Main: 275677184 15:50:46 INFO - PROCESS | 21217 | 15:50:46 INFO - PROCESS | 21217 | __start_tp_report 15:50:46 INFO - PROCESS | 21217 | _x_x_mozilla_page_load 15:50:46 INFO - PROCESS | 21217 | _x_x_mozilla_page_load_details 15:50:46 INFO - PROCESS | 21217 | |i|pagename|runs| 15:50:46 INFO - PROCESS | 21217 | |0;dojo.html;2557.411795287084;2648.192301348088;2655.203438968309;2658.920232393029;2683.8523881186525;4454.599086082252;4525.185466616008;4536.9092618147615;4541.7047891887005;4570.725756454611;4597.724136551809;4607.124646317206;4616.238320677085;4630.236011058179;4630.907381852369;4137.234611596849;4216.915661686772;4256.042390462152;4303.139372125572;4313.202057619351;4124.97937510312;4238.533761286271;4268.9114275859765;4279.507856596485;4293.592108749664;4184.727992680497;4210.705250632473;4234.830606775725;4240.257954857888;4265.808038638269;4221.978890105561;4239.215745087169;4246.681498887565;4250.766207858566;4290.76400797956;4225.873223803291;4232.280512312884;4247.065645557972;4264.808083636244;4270.081932384521;4378.912421751547;4455.710378825366;4507.323901414814;4556.248219043854;4556.2937744649635;4926.753662316905;4948.529889660476;4949.925751113737;4949.925751113737;4990.326305948687;4827.444843842968;4950.6782059166035;4952.306677065214;4958.107540642683;4959.752012399402;4594.2419500782335;4647.326137710081;4680.251159814447;4680.46174689915;4689.390379250675;5026.84919452417;5056.089903817348;5060.291559181717;5064.442911279756;5105.744712764347;4723.385959825201;4825.9758701206265;4855.271709243641;4855.951440485621;4862.513748625109;4837.975810120997;4857.052874689472;4857.611391088704;4877.561019508261;4900.2894580286375;4822.228443449031;4825.131476334223;4827.734474603931;4828.082664293773;4865.026994601094;4706.929396059062;4787.42550893895;4797.4482934462985;4837.129316723023;4867.026594681078;4051.91896162081;4054.8580799671868;4072.7963601819793;4081.3469844824685;4098.7950602469755;3584.5877724061547;3586.9103272418397;3601.081724160322;3619.4027985382645;3633.7456378053284;4091.4067460218102;4161.459010328698;4205.663546916239;4206.936895946563;4250.702450828412;4887.29134275528;4928.605711543068;4938.061768264019;4940.1601727706375;4956.925646115311;4233.364995250737;4236.110416812504;4237.936430953539;4266.893327666833;4276.2516559601945;4256.957430425656;4332.870013899588;4365.890852728708;4379.277419225856;4401.845935392246;4668.92996605058;4685.039566888711;4686.742229177292;4722.338872557844;4729.55069268419;4918.4097908249805;4920.434150072644;4922.975385123052;4928.753562321941;4986.252062190701;4532.5694059064335;4590.036092420495;4670.906581868276;4682.555157260055;4689.273162659793;4857.174280372275;4869.0261947609915;4871;4878.341423907727;4922.950770492393;4908.901821963469;4956.504349565014;4964.801407943642;4967.05625931072;5017.422996355466;4680.040591678629;4749.548792864673;4770.236762118045;4792.2332426811545;4810.254410566367;4744.976275118603;4761.547652972962;4779.545943135397;4780.545848144421;4814.133455977958;4567.771611419482;4682.601978831701;4686.8125274988615;4690.15577196108;4732.597729193058;4769.856904292877;4803.879903002453;4806.639502037431;4824.855254342376;4855.514448555116;4660.347551342747;4698.3657206278085;4703.412073490814;4704.811807527797;4749.786259618395 15:50:46 INFO - PROCESS | 21217 | |1;ext.html;499.40071913703565;501.0155045335914;502.16640376974226;526.357843431014;529.0556356902929;25480.23559293222;25943.091991780293;33497.33005339892;33756.32487350251;33788.155296117606;37315.58923956025;37840.621593784126;37856.24287514248;37871;37913.431298530544;7639.121501027384;7833.725819596315;7836.255555722198;7838.490498117632;7841;7663.501872378305;7795.1035630902325;7824.413169012319;7841.647125879349;7844.686212551491;7969.72105976288;8049.758507244792;8078.1921807819335;8078.515289082674;8080.838383232362;7950.363970882345;8030.437869349148;8039.718609848685;8040.276375126237;8043.477173983672;7912.0505539335645;8059.274665280153;8062.798430039237;8063;8074;37519.62480375189;37865.43201851974;37982.05044873873;38022.23955520902;38043;2691.1242369376505;2810.142906413543;2810.18504633656;2948.9262768430744;3038.179691483287;28405.857970710014;28646;28653;28752.712472875213;29512.26219344512;3397.5243465914546;3498.352804731133;3503.194265318991;3543.114221444639;3601.3697602919647;215033;217269;217278;217624.9118754412;217655;51574.48425515697;52908.470915291124;53112.468875311526;53176;53187.73406133022;56899;57219.71390143106;59938;60997.39002610006;61022.69488652617;11740.589079382351;11861;11909.58316458937;11910.761784764429;11959.521619135312;8900.376973611914;8992.55037248148;9000.36997410188;9003.14470125337;9011.143941325563;19000.144993475325;19007.243949627504;19124.904375478312;19142.521436963907;19182.424527264204;7334.4132469403385;7581.696732130763;7612.885806712904;7641.69433222676;7693.884591731128;810.4893916832358;840.932725381968;882.4440602420434;902.2015516268019;914.2457472585144;26474.6028809568;26659.733402666112;27027.86486067557;27114.72885271122;27146.185614431597;849.4563479373206;906.2840356118593;972.0668158567713;1047.36634336227;1050.5377633841085;11835.644930652094;12377.133600648049;12515.937420313023;12588.559400420942;12594.748105038032;191942;194496;194499.02750486156;194872;194929;35568;35714.10714732153;36179.27641447156;36552;36572;1098.7033500954858;1111.6553868300853;1128.2666266926562;1157;1157.3576664950865;23428.53142937166;25618.975240990152;26253.73746262513;26756.866215668797;26817.731822681522;36680.81659591685;36801.447978279815;37034.259314814095;37117.44323835199;37150.814245928595;166438;167715;167735;167918;214117;28082;28346.574801377585;28352.85823570869;28395.432091357645;28582.14253572396;36945.26109477849;36978.26043479169;37694.8115259422;38056.80971595124;38125.61874381221;31219;31580.526292105176;31650.366992660478;32324.67675323217;32561.348773023932;31492.527612085378;31972;32020.5196922051;32177.356452870343;32464.350712985135;31769.8411507941;31915.202119946258;32279;32284.35431291314;32304.35391292208;26141.346466338495;28363.290917727223;28589.571156432256;28658.85670571634;28690.282742931595;22518.4370390735;22887.656685149403;22986.601462112194;23064.308070757903;23135.88432057829 15:50:46 INFO - PROCESS | 21217 | |2;jquery.html;334.9313390754896;340.13944719858733;341.29863131265256;342.4982400782853;342.7429427929053;14484;14974.176420296879;15505.612359690986;15580.454684086058;15615;13874.30628468575;14227.573172804832;14500.782488262685;15061;15191.316390762415;4876.561109500135;5036.6222533309965;5042.722650254234;5045.369328833895;5066.037452883958;4888.120138375091;4890.119778439897;4896.265560165986;5019.54824065834;5045;4958.2562615607585;4987.950120498803;4990;4992.875178120558;5017.147084995559;4958.0579689859;4968.677035992649;4972.87567810804;6198.783042593487;6510.18622672166;6195.039768835838;6211.720472578745;6226.968865155645;6231.345708700566;6234.781782637586;19537;20759.5848083039;21396.358109256747;21521;21534.138634454604;1691.2220378625848;1752.8948263104255;1759.0325321073358;1801.9459416217403;1819.672458957387;13187.472501099945;13658.521951731742;13744.931275343659;14132.434702611883;14355.928220358936;1905.8856468611928;1915.0999030455664;1961.892095934723;1992.1533348326902;1994.222253321206;58532;59990.40009599892;60542.69728651373;63008.36991630117;64194;15263.771043434357;15662.37350505967;15664.451744188898;15711.68576628484;15769.526914192593;23115;23304.65043024356;23340.76659233386;23419.53160936806;23443.7655623445;7788.649510772028;7882.605869706492;7985.840283194304;8021.318187954089;8129.146439623754;6519.282878883319;6557.8360540985905;6622.86754264912;6648.301928297556;6657;7564;7739.651715672809;7753.534787912743;7761.805954851174;7786;2883.68279489256;2893.551499517578;2956.659984101856;3001.8048826826184;3006.5790789289517;765.6363227466909;803.8866170354102;823.074041703084;862.7368652560904;923.0584803500392;14545.127292362493;14747.705045899022;15198.544043678707;15339.079655220723;15783.842161578466;807.9313258372987;814.9429539932148;829.369679043919;859.0121360435425;871.7079778274349;8543.40196186261;8621.956890215508;8875.245604123593;8906.955465222762;9107.726768196964;379626;403495;411096;411249;412115;62350;64673.35326646674;64938.67530662316;64946;65255.347446524924;840.3655240293539;864.4510735682886;868.3270465389247;870.216804875617;877.6489404238356;14077.648058798612;14096.506622268582;14411.42354305858;14715;14733.26333683333;29007.274818129714;30427.695723042485;30478.542821857245;30848;31033.379332412773;40513.79743101266;41772.373414399415;42423;42527.787361064235;42773.35839962465;7090.326418990187;7119.67961441726;7226.421886248982;7278.563286202845;7343.8531229376185;9281.535923203677;10971.451427428756;11043.503042362952;11164.330140191614;11339.433028348714;9426.858597120912;9571.234301256021;9655.806883862142;9856.605735770489;9866.112049915542;9494.810103797747;9724.659636912675;9791.706248812547;9811.116999470081;9857.162141218078;9123.635054597742;9831.459269739948;9856.162226210565;10048.54781534818;10078.445685487368;7077.68150433242;7249.456290778318;7258.709651613876;7310.890336645061;7362.5214361066355;7665.003549538525;9542.475163866055;9900.702978910644;9994.450305233282;10090.2432317575 15:50:46 INFO - PROCESS | 21217 | |3;mootools.html;1196.7666305070516;1347.7910923806808;1351.5202103253348;1465.3845384938325;1706.4880535839245;7186.9640651796735;7372.3364897159245;7393.8151546211375;7399.334059934605;7455.217202193773;7156.821079473016;7292.63536823158;7304.780856574298;7307.159676637175;7308.96345518273;1842.5025243184332;1894.0340426382575;1897.6489349470392;2145.8068773810355;2181.0839447432036;2194.045590168274;2262.072550254396;2263.7057182566327;2265.716785401825;2266.2974477911816;2186.606410846047;2221.822254219667;2230.230570453199;2232.084845213463;2237.686723858661;2157.2665293800183;2161.6217161996665;2168.7831216878344;2169.370882444089;2172.0443005077714;2132.6587745960574;2197.099189332382;2200.273909609825;2210.281658461007;2218.944526386837;7619.6571154297635;7658.157602663702;7665.195154508752;7675.53946763196;7677.73127940525;4546.29532422475;4645.790939407735;4673.626109911199;4675.158471475133;4680.7191568506;2829.2502486841004;2905.3584724630514;2920.109366643173;2942.867570959312;2944.1903476543907;908.4367692030917;912.5847739278612;913.0914739833908;947.5641205045687;959.4435227567993;10397.84403233952;10511.106555942677;10519.263651544396;10529.315594486334;10534.26260161789;4330.0906809569715;4338.110687309094;4347.0871117065135;4409.184300904279;4412.360207769855;8832.470051796912;8970.237529809909;8987.19115279628;8990.157017811332;8998.730038098867;4553.817847286072;4577.885552861138;4601.24079526881;4604.562566556172;4608.6082682971655;3468.3930312195266;4028.7784171870244;4130.545639979599;4136.44158038667;4190.622843943998;3579.94630080549;3602.2615363850346;3603.657652523006;3652.178259891556;3654.214343916071;1130.1015692524463;1141.8401423800674;1144.2848219862585;1159.5072094359864;1162.035510526261;1183.071289038101;1188.5245901639241;1194.1939191046008;1198.7302856857311;1202.1825158891863;7120.323569260912;7131.750388736369;7184.425245980309;7190.784276471714;7285.562866228043;440.12854547995147;451.1923656654617;451.36357735592657;453.98411055612894;456.3246395334923;5399.298091248191;5425.321834770653;5437.700926449083;5439.156930675673;5466.098093814556;9003.14470125337;9277;9494.572744226527;9639.759006024766;9644.421334719938;9339.953300233456;9361.765955851022;9431.104045115702;9504.287178461644;9519.952400237955;6911.5853048817235;7212.278772122746;7216.5670059796585;7239.5294305871;7312.707491700273;6880.827979300358;6909.481788865754;6916.861662766817;6928.960655901655;6942.201646810681;8226.588670566329;8345.874811877706;8351.457155284887;8369;8537.146285371413;8420.326373889951;8690.652373905226;8828.646854125764;8852.203301702877;8855.73432797017;6550.967245163934;6617.7683781067435;6667.799966000834;6670.066190733204;6670.433013193739;7304.780856574312;7314.451416143704;7345.8898116527225;7348.3386495213545;7348.889766653398;6526.086347911201;6697.330266973264;6712.228093769279;6778.830529236809;6851.4176295013485;6548.541602087808;6586.8353291168105;6619.040239165391;6672.699728512326;6677.599344039373;6834.487413443912;6847.383735463832;6943.861122777617;6945.270746571739;6947.930520694728;6377.266614339224;6431.646259455775;6476.70854811544;6486.578372405778;6490.3185165558825;6458.612483250832;6495.870082598416;6506.934930650822;6513.250976137615;6522.804315870531 15:50:46 INFO - PROCESS | 21217 | |4;prototype.html;309.8326903472125;310.7871108290821;312.3487528503071;316.40673736743605;317.9666135055818;5178.275041494189;5225.581953443725;5245.291885595443;5250.501202385767;5250.579953603712;5174.990876779029;5200.713960732158;5234.057869583474;5237.214417837326;5242.659227150232;3901.7463864848837;3994.840206391741;4082.4692789937267;4090.795460226977;4109.506859176903;4049.6962727795385;4063.0654949361665;4079.2045551117544;4084.1831633673237;4086.1010577672864;4052.925974616729;4054.939175912349;4058.330375488056;4091.161311931047;4091.1817636472674;3855.3445914194654;3957.6042395760337;4026.57720939303;4040.454538637305;4043.9595604043875;3556.751027428081;3558.3594952908466;3569.39320315547;3571.8749843755604;3572.214112895159;4961.950380496221;5042.319286896259;5043.394792624872;5047.167217409123;5055.140626093536;4683.648726345504;4687.6249900007915;4696.342512048316;4698.201305778026;4704.506026867198;5508.9724551377385;5519.144532597454;5521.558275337963;5522.088855338864;5536.307961504812;3925.156091440354;3928.410738389236;3928.6857051436104;3929.803509824526;3936.822842972073;5542.307211598551;5805.3323867755325;5808.88382232353;5812.157237200625;5813.796517121923;4029.9395509066803;4045.8381664733083;4047.757134571876;4050.4936882889638;4051.9870032491876;4105.958940410557;4107.383892416162;4111.671066314688;4116.0327323079055;4117.876463706094;4652.3951886255245;4663.48701642819;4664.323673067386;4665.3934988451965;4671.789769460383;5483.670979741229;5517.668939863621;5518.586106042063;5519.613627046148;5520.067976208295;1432.298173894805;1455.2796365798997;1458.7228426598913;1459.0661976335155;1465.377214683755;900.4687234531527;962.9518524073768;979.4515071559949;994.751312171957;1010.9191264698807;4773.95226047742;4782.258749893772;4791.233402655628;4795.472498025214;4800.591949684246;5609.046462101453;5631.71841407928;5634.605577609528;5637.8590535236945;5646.830595082154;4770.785314660849;4777.3072904429355;4780.043991201774;4786.425628924481;4789.664723469394;2993.925151871221;3030.5454181872456;3035.6357237131688;3038.498647723101;3040.0271912987632;5350.91973620396;5354.437784032699;5363.088274993261;5363.624546281723;5364.704941228192;5693.658380497183;5729.713514324267;5915.792947246826;5916.26046744157;5916.852078698067;5425.430329815313;5444.646098003617;5447.046766815871;5453.618246722771;5456.508914197741;5735.053716136791;5740.282464691913;5744.712764361849;5745.6552606843725;5750.6837123958585;5613.438656134517;5625.634333768292;5631.0427227372265;5638.971805140948;5646.153077038312;5448.155535891943;5448.237246785374;5451.754671039734;5458.344998600193;5463.562914966873;3711.146436319608;3828.2917660231833;3833.7316387852584;3836.76979381238;3880.9223815524097;5667.121596152603;5683.431656834284;5709.000924838219;5709.771609135588;5709.9714501427225;5484.314460692413;5497.587680924026;5497.725113744217;5500.834974950758;5501.5323697486165;5457.69982650958;5474.288342515607;5480.040992826319;5480.232767412485;5498.615096943336;5369.301990741179;5387;5391.649542779707;5393.622446428869;5394.973025134849;5349.224362467498;5539.944600553943;5595.300587426572;5603.635763675348;5604.747786349542;5431.103867861917;5450.672959622435;5452.26394436746;5456.699881506555;5458.563314934875 15:50:46 INFO - PROCESS | 21217 | |5;yui.html;653.7025653327736;700.9123859517559;715.7834209887127;736.1497470421658;748.1844789179793;11125.332480051193;11201.159913006537;11229.831552526719;11267.718307042329;11319.943400282997;10971.561137554489;10983.286086404398;11020.614278500254;11022.228444008922;11028.944855275733;603.3604379357873;773.5358784729174;778.1557010643459;788.7239466186846;790.0124843945068;791.4143533785016;791.9089304729972;792.4254915186501;794.6146119132245;799.8080460689422;843.5613480989881;848.8259906719107;849.3417601358934;849.817289282804;850.2220468271524;634.3181080338609;818.0837462042491;836.2766207230732;836.4479443567246;838.5094719588986;621.353792056261;621.9036049412348;622.0203179991486;622.1849377315731;622.3714048810689;11930.284182949052;11958.641240762705;11975;12006.279623222634;12025.338606376647;11158.609448669258;11627.244229125165;11641.126915481289;11738.706532336675;11923;9569.760755981086;9775.90224097764;9897.4556399398;9909.306348555603;9946.055124763136;3232.3696879108584;3249.2526718854797;3275.8034517929;3355.597328320617;3357.84889679965;40176.79911600423;40550;40579.1884162318;40632.79683601593;40635.593644063476;9456.669016584387;9782.706518804447;9837.458939758239;9839.60641574329;9999;17342.739858902125;17403.129843507773;17434.738478922827;17441.389551365643;17455.73816392755;6275.02737075754;6321.747130114744;6351.237851457855;6392.456641185551;6577.046328282468;3462.23830757233;3535.7524973251625;3555.626659200747;3561.5726112866623;3563.6970857477404;2615.5553555895544;2655.5087308847924;2671.2921075914896;2676.0500022492124;2676.7055623881356;406.1746452148457;474.57288440403914;475.310799340957;490.0884355099512;493.27242317581283;464.30122665389047;534.8816400385742;565.5673409841474;568.8066057540374;582.5514353947436;7296.927030729731;7636.647553497747;7916.208379162038;8000.239977202156;8026.638801253957;441.3313829548237;546.66926509462;551.8136007583727;562.9662220266797;578.3291381996863;3630.5643322801434;3640.9453858192146;3645.526081609427;3666.944995825065;3774.6225377462033;46064.53935460602;48285.75857120692;48389;48576.75711621419;48775.756121219165;42187;42522.57477425248;42684;42819.78590107092;43467.34798978018;38825.22349552993;39697.404538931936;39971.20057598832;40061.198776024314;40175.59824401777;8138.593070346577;8262.873568915054;8280;8467.258335332233;8475.364347673825;30136.698633013388;30863;31329.8433507831;31345.373092537564;31535.526967095055;33882.49176262309;34148.31703365968;34237.486437703956;37626;38969;9665.598488219028;9871.65449209303;10093.5457904393;10195.082442580204;10543.420111893613;10423.895761042293;10433.634822781167;10468;10620.628278010232;11903.345316007357;10603.469826508797;10948.178886583697;10994.450277486254;11307.038901693448;11390.316581005167;9965.60137594517;10136.391816491034;10328.211382926718;10641.627543035956;10712.678619641423;9775.657851975147;10094.293399461967;10128.189744820544;10214.693559193236;10475.738106547396;8664.220220180214;8906.554672266231;8916.73249802507;9079.591418386057;9154.862677059717;8479.915200847912;8653.783655408664;8879.778005549913;9203.40177888435;9589 15:50:46 INFO - PROCESS | 21217 | __end_tp_report 15:50:46 INFO - PROCESS | 21217 | __start_cc_report 15:50:46 INFO - PROCESS | 21217 | _x_x_mozilla_cycle_collect,818 15:50:46 INFO - PROCESS | 21217 | __end_cc_report 15:50:46 INFO - PROCESS | 21217 | __startTimestamp1457567446879__endTimestamp 15:50:46 INFO - PROCESS | 21217 | 15:50:46 INFO - PROCESS | 21217 | ------- Summary: start ------- 15:50:46 INFO - PROCESS | 21217 | Number of tests: 6 15:50:46 INFO - PROCESS | 21217 | 15:50:46 INFO - PROCESS | 21217 | [#0] dojo.html Cycles:165 Average:4534.38 Median:4682.60 stddev:470.43 (10.0%) stddev-sans-first:445.58 15:50:46 INFO - PROCESS | 21217 | Values: 2557.4 2648.2 2655.2 2658.9 2683.9 4454.6 4525.2 4536.9 4541.7 4570.7 4597.7 4607.1 4616.2 4630.2 4630.9 4137.2 4216.9 4256.0 4303.1 4313.2 4125.0 4238.5 4268.9 4279.5 4293.6 4184.7 4210.7 4234.8 4240.3 4265.8 4222.0 4239.2 4246.7 4250.8 4290.8 4225.9 4232.3 4247.1 4264.8 4270.1 4378.9 4455.7 4507.3 4556.2 4556.3 4926.8 4948.5 4949.9 4949.9 4990.3 4827.4 4950.7 4952.3 4958.1 4959.8 4594.2 4647.3 4680.3 4680.5 4689.4 5026.8 5056.1 5060.3 5064.4 5105.7 4723.4 4826.0 4855.3 4856.0 4862.5 4838.0 4857.1 4857.6 4877.6 4900.3 4822.2 4825.1 4827.7 4828.1 4865.0 4706.9 4787.4 4797.4 4837.1 4867.0 4051.9 4054.9 4072.8 4081.3 4098.8 3584.6 3586.9 3601.1 3619.4 3633.7 4091.4 4161.5 4205.7 4206.9 4250.7 4887.3 4928.6 4938.1 4940.2 4956.9 4233.4 4236.1 4237.9 4266.9 4276.3 4257.0 4332.9 4365.9 4379.3 4401.8 4668.9 4685.0 4686.7 4722.3 4729.6 4918.4 4920.4 4923.0 4928.8 4986.3 4532.6 4590.0 4670.9 4682.6 4689.3 4857.2 4869.0 4871.0 4878.3 4923.0 4908.9 4956.5 4964.8 4967.1 5017.4 4680.0 4749.5 4770.2 4792.2 4810.3 4745.0 4761.5 4779.5 4780.5 4814.1 4567.8 4682.6 4686.8 4690.2 4732.6 4769.9 4803.9 4806.6 4824.9 4855.5 4660.3 4698.4 4703.4 4704.8 4749.8 15:50:46 INFO - PROCESS | 21217 | 15:50:46 INFO - PROCESS | 21217 | [#1] ext.html Cycles:180 Average:35637.47 Median:33772.24 stddev:51073.24 (151.2%) stddev-sans-first:51148.37 15:50:46 INFO - PROCESS | 21217 | Values: 499.4 501.0 502.2 526.4 529.1 25480.2 25943.1 33497.3 33756.3 33788.2 37315.6 37840.6 37856.2 37871.0 37913.4 7639.1 7833.7 7836.3 7838.5 7841.0 7663.5 7795.1 7824.4 7841.6 7844.7 7969.7 8049.8 8078.2 8078.5 8080.8 7950.4 8030.4 8039.7 8040.3 8043.5 7912.1 8059.3 8062.8 8063.0 8074.0 37519.6 37865.4 37982.1 38022.2 38043.0 2691.1 2810.1 2810.2 2948.9 3038.2 28405.9 28646.0 28653.0 28752.7 29512.3 3397.5 3498.4 3503.2 3543.1 3601.4 215033.0 217269.0 217278.0 217624.9 217655.0 51574.5 52908.5 53112.5 53176.0 53187.7 56899.0 57219.7 59938.0 60997.4 61022.7 11740.6 11861.0 11909.6 11910.8 11959.5 8900.4 8992.6 9000.4 9003.1 9011.1 19000.1 19007.2 19124.9 19142.5 19182.4 7334.4 7581.7 7612.9 7641.7 7693.9 810.5 840.9 882.4 902.2 914.2 26474.6 26659.7 27027.9 27114.7 27146.2 849.5 906.3 972.1 1047.4 1050.5 11835.6 12377.1 12515.9 12588.6 12594.7 191942.0 194496.0 194499.0 194872.0 194929.0 35568.0 35714.1 36179.3 36552.0 36572.0 1098.7 1111.7 1128.3 1157.0 1157.4 23428.5 25619.0 26253.7 26756.9 26817.7 36680.8 36801.4 37034.3 37117.4 37150.8 166438.0 167715.0 167735.0 167918.0 214117.0 28082.0 28346.6 28352.9 28395.4 28582.1 36945.3 36978.3 37694.8 38056.8 38125.6 31219.0 31580.5 31650.4 32324.7 32561.3 31492.5 31972.0 32020.5 32177.4 32464.4 31769.8 31915.2 32279.0 32284.4 32304.4 26141.3 28363.3 28589.6 28658.9 28690.3 22518.4 22887.7 22986.6 23064.3 23135.9 15:50:46 INFO - PROCESS | 21217 | 15:50:46 INFO - PROCESS | 21217 | [#2] jquery.html Cycles:180 Average:24049.79 Median:4988.98 stddev:66022.85 (1323.4%) stddev-sans-first:66184.05 15:50:46 INFO - PROCESS | 21217 | Values: 334.9 340.1 341.3 342.5 342.7 14484.0 14974.2 15505.6 15580.5 15615.0 13874.3 14227.6 14500.8 15061.0 15191.3 4876.6 5036.6 5042.7 5045.4 5066.0 4888.1 4890.1 4896.3 5019.5 5045.0 4958.3 4988.0 4990.0 4992.9 5017.1 4958.1 4968.7 4972.9 6198.8 6510.2 6195.0 6211.7 6227.0 6231.3 6234.8 19537.0 20759.6 21396.4 21521.0 21534.1 1691.2 1752.9 1759.0 1801.9 1819.7 13187.5 13658.5 13744.9 14132.4 14355.9 1905.9 1915.1 1961.9 1992.2 1994.2 58532.0 59990.4 60542.7 63008.4 64194.0 15263.8 15662.4 15664.5 15711.7 15769.5 23115.0 23304.7 23340.8 23419.5 23443.8 7788.6 7882.6 7985.8 8021.3 8129.1 6519.3 6557.8 6622.9 6648.3 6657.0 7564.0 7739.7 7753.5 7761.8 7786.0 2883.7 2893.6 2956.7 3001.8 3006.6 765.6 803.9 823.1 862.7 923.1 14545.1 14747.7 15198.5 15339.1 15783.8 807.9 814.9 829.4 859.0 871.7 8543.4 8622.0 8875.2 8907.0 9107.7 379626.0 403495.0 411096.0 411249.0 412115.0 62350.0 64673.4 64938.7 64946.0 65255.3 840.4 864.5 868.3 870.2 877.6 14077.6 14096.5 14411.4 14715.0 14733.3 29007.3 30427.7 30478.5 30848.0 31033.4 40513.8 41772.4 42423.0 42527.8 42773.4 7090.3 7119.7 7226.4 7278.6 7343.9 9281.5 10971.5 11043.5 11164.3 11339.4 9426.9 9571.2 9655.8 9856.6 9866.1 9494.8 9724.7 9791.7 9811.1 9857.2 9123.6 9831.5 9856.2 10048.5 10078.4 7077.7 7249.5 7258.7 7310.9 7362.5 7665.0 9542.5 9900.7 9994.5 10090.2 15:50:46 INFO - PROCESS | 21217 | 15:50:46 INFO - PROCESS | 21217 | [#3] mootools.html Cycles:180 Average:5323.05 Median:6493.09 stddev:2832.96 (43.6%) stddev-sans-first:2823.93 15:50:46 INFO - PROCESS | 21217 | Values: 1196.8 1347.8 1351.5 1465.4 1706.5 7187.0 7372.3 7393.8 7399.3 7455.2 7156.8 7292.6 7304.8 7307.2 7309.0 1842.5 1894.0 1897.6 2145.8 2181.1 2194.0 2262.1 2263.7 2265.7 2266.3 2186.6 2221.8 2230.2 2232.1 2237.7 2157.3 2161.6 2168.8 2169.4 2172.0 2132.7 2197.1 2200.3 2210.3 2218.9 7619.7 7658.2 7665.2 7675.5 7677.7 4546.3 4645.8 4673.6 4675.2 4680.7 2829.3 2905.4 2920.1 2942.9 2944.2 908.4 912.6 913.1 947.6 959.4 10397.8 10511.1 10519.3 10529.3 10534.3 4330.1 4338.1 4347.1 4409.2 4412.4 8832.5 8970.2 8987.2 8990.2 8998.7 4553.8 4577.9 4601.2 4604.6 4608.6 3468.4 4028.8 4130.5 4136.4 4190.6 3579.9 3602.3 3603.7 3652.2 3654.2 1130.1 1141.8 1144.3 1159.5 1162.0 1183.1 1188.5 1194.2 1198.7 1202.2 7120.3 7131.8 7184.4 7190.8 7285.6 440.1 451.2 451.4 454.0 456.3 5399.3 5425.3 5437.7 5439.2 5466.1 9003.1 9277.0 9494.6 9639.8 9644.4 9340.0 9361.8 9431.1 9504.3 9520.0 6911.6 7212.3 7216.6 7239.5 7312.7 6880.8 6909.5 6916.9 6929.0 6942.2 8226.6 8345.9 8351.5 8369.0 8537.1 8420.3 8690.7 8828.6 8852.2 8855.7 6551.0 6617.8 6667.8 6670.1 6670.4 7304.8 7314.5 7345.9 7348.3 7348.9 6526.1 6697.3 6712.2 6778.8 6851.4 6548.5 6586.8 6619.0 6672.7 6677.6 6834.5 6847.4 6943.9 6945.3 6947.9 6377.3 6431.6 6476.7 6486.6 6490.3 6458.6 6495.9 6506.9 6513.3 6522.8 15:50:46 INFO - PROCESS | 21217 | 15:50:46 INFO - PROCESS | 21217 | [#4] prototype.html Cycles:180 Average:4576.09 Median:5235.64 stddev:1336.30 (25.5%) stddev-sans-first:1301.12 15:50:46 INFO - PROCESS | 21217 | Values: 309.8 310.8 312.3 316.4 318.0 5178.3 5225.6 5245.3 5250.5 5250.6 5175.0 5200.7 5234.1 5237.2 5242.7 3901.7 3994.8 4082.5 4090.8 4109.5 4049.7 4063.1 4079.2 4084.2 4086.1 4052.9 4054.9 4058.3 4091.2 4091.2 3855.3 3957.6 4026.6 4040.5 4044.0 3556.8 3558.4 3569.4 3571.9 3572.2 4962.0 5042.3 5043.4 5047.2 5055.1 4683.6 4687.6 4696.3 4698.2 4704.5 5509.0 5519.1 5521.6 5522.1 5536.3 3925.2 3928.4 3928.7 3929.8 3936.8 5542.3 5805.3 5808.9 5812.2 5813.8 4029.9 4045.8 4047.8 4050.5 4052.0 4106.0 4107.4 4111.7 4116.0 4117.9 4652.4 4663.5 4664.3 4665.4 4671.8 5483.7 5517.7 5518.6 5519.6 5520.1 1432.3 1455.3 1458.7 1459.1 1465.4 900.5 963.0 979.5 994.8 1010.9 4774.0 4782.3 4791.2 4795.5 4800.6 5609.0 5631.7 5634.6 5637.9 5646.8 4770.8 4777.3 4780.0 4786.4 4789.7 2993.9 3030.5 3035.6 3038.5 3040.0 5350.9 5354.4 5363.1 5363.6 5364.7 5693.7 5729.7 5915.8 5916.3 5916.9 5425.4 5444.6 5447.0 5453.6 5456.5 5735.1 5740.3 5744.7 5745.7 5750.7 5613.4 5625.6 5631.0 5639.0 5646.2 5448.2 5448.2 5451.8 5458.3 5463.6 3711.1 3828.3 3833.7 3836.8 3880.9 5667.1 5683.4 5709.0 5709.8 5710.0 5484.3 5497.6 5497.7 5500.8 5501.5 5457.7 5474.3 5480.0 5480.2 5498.6 5369.3 5387.0 5391.6 5393.6 5395.0 5349.2 5539.9 5595.3 5603.6 5604.7 5431.1 5450.7 5452.3 5456.7 5458.6 15:50:46 INFO - PROCESS | 21217 | 15:50:46 INFO - PROCESS | 21217 | [#5] yui.html Cycles:180 Average:12018.85 Median:43143.57 stddev:13321.53 (30.9%) stddev-sans-first:13331.55 15:50:46 INFO - PROCESS | 21217 | Values: 653.7 700.9 715.8 736.1 748.2 11125.3 11201.2 11229.8 11267.7 11319.9 10971.6 10983.3 11020.6 11022.2 11028.9 603.4 773.5 778.2 788.7 790.0 791.4 791.9 792.4 794.6 799.8 843.6 848.8 849.3 849.8 850.2 634.3 818.1 836.3 836.4 838.5 621.4 621.9 622.0 622.2 622.4 11930.3 11958.6 11975.0 12006.3 12025.3 11158.6 11627.2 11641.1 11738.7 11923.0 9569.8 9775.9 9897.5 9909.3 9946.1 3232.4 3249.3 3275.8 3355.6 3357.8 40176.8 40550.0 40579.2 40632.8 40635.6 9456.7 9782.7 9837.5 9839.6 9999.0 17342.7 17403.1 17434.7 17441.4 17455.7 6275.0 6321.7 6351.2 6392.5 6577.0 3462.2 3535.8 3555.6 3561.6 3563.7 2615.6 2655.5 2671.3 2676.1 2676.7 406.2 474.6 475.3 490.1 493.3 464.3 534.9 565.6 568.8 582.6 7296.9 7636.6 7916.2 8000.2 8026.6 441.3 546.7 551.8 563.0 578.3 3630.6 3640.9 3645.5 3666.9 3774.6 46064.5 48285.8 48389.0 48576.8 48775.8 42187.0 42522.6 42684.0 42819.8 43467.3 38825.2 39697.4 39971.2 40061.2 40175.6 8138.6 8262.9 8280.0 8467.3 8475.4 30136.7 30863.0 31329.8 31345.4 31535.5 33882.5 34148.3 34237.5 37626.0 38969.0 9665.6 9871.7 10093.5 10195.1 10543.4 10423.9 10433.6 10468.0 10620.6 11903.3 10603.5 10948.2 10994.5 11307.0 11390.3 9965.6 10136.4 10328.2 10641.6 10712.7 9775.7 10094.3 10128.2 10214.7 10475.7 8664.2 8906.6 8916.7 9079.6 9154.9 8479.9 8653.8 8879.8 9203.4 9589.0 15:50:46 INFO - PROCESS | 21217 | -------- Summary: end -------- 15:50:46 INFO - PROCESS | 21217 | 15:50:47 INFO - TEST-INFO | 21217: exit 0 15:50:47 INFO - TEST-OK | dromaeo_css | took 1116851ms 15:50:47 INFO - TEST-START | kraken 15:50:47 INFO - operating with platform_type : linux_ 15:50:47 INFO - Initialising browser for kraken test... 15:50:47 INFO - TEST-INFO | started process 21397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy9cGZu/profile http://localhost:35389/getInfo.html) 15:50:52 INFO - PROCESS | 21397 | __metrics Screen width/height:1600/1200 15:50:52 INFO - PROCESS | 21397 | colorDepth:24 15:50:52 INFO - PROCESS | 21397 | Browser inner width/height: 1024/697 15:50:52 INFO - PROCESS | 21397 | __metrics 15:50:53 ERROR - PROCESS | 21397 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:50:54 INFO - TEST-INFO | 21397: exit 0 15:50:54 INFO - Browser initialized. 15:50:54 INFO - Running cycle 1/1 for kraken test... 15:50:54 INFO - TEST-INFO | started process 21478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy9cGZu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:06 INFO - PROCESS | 21478 | RSS: Main: 153665536 15:51:06 INFO - PROCESS | 21478 | 15:51:08 INFO - PROCESS | 21478 | Cycle 1(1): loaded http://localhost:35389/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35389/tests/kraken/driver.html?testName=audio-beat-detection) 15:51:09 INFO - PROCESS | 21478 | RSS: Main: 195575808 15:51:09 INFO - PROCESS | 21478 | 15:51:11 INFO - PROCESS | 21478 | Cycle 1(1): loaded http://localhost:35389/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35389/tests/kraken/driver.html?testName=audio-dft) 15:51:12 INFO - PROCESS | 21478 | RSS: Main: 184188928 15:51:12 INFO - PROCESS | 21478 | 15:51:15 INFO - PROCESS | 21478 | Cycle 1(1): loaded http://localhost:35389/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35389/tests/kraken/driver.html?testName=audio-fft) 15:51:16 INFO - PROCESS | 21478 | RSS: Main: 173588480 15:51:16 INFO - PROCESS | 21478 | 15:51:18 INFO - PROCESS | 21478 | Cycle 1(1): loaded http://localhost:35389/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35389/tests/kraken/driver.html?testName=audio-oscillator) 15:51:18 INFO - PROCESS | 21478 | RSS: Main: 174878720 15:51:18 INFO - PROCESS | 21478 | 15:51:21 INFO - PROCESS | 21478 | Cycle 1(1): loaded http://localhost:35389/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35389/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:51:21 INFO - PROCESS | 21478 | RSS: Main: 174678016 15:51:21 INFO - PROCESS | 21478 | 15:51:24 INFO - PROCESS | 21478 | Cycle 1(1): loaded http://localhost:35389/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35389/tests/kraken/driver.html?testName=imaging-darkroom) 15:51:25 INFO - PROCESS | 21478 | RSS: Main: 174620672 15:51:25 INFO - PROCESS | 21478 | 15:51:28 INFO - PROCESS | 21478 | Cycle 1(1): loaded http://localhost:35389/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35389/tests/kraken/driver.html?testName=imaging-desaturate) 15:51:29 INFO - PROCESS | 21478 | RSS: Main: 172867584 15:51:29 INFO - PROCESS | 21478 | 15:51:32 INFO - PROCESS | 21478 | Cycle 1(1): loaded http://localhost:35389/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35389/tests/kraken/driver.html?testName=json-parse-financial) 15:51:33 INFO - PROCESS | 21478 | RSS: Main: 174895104 15:51:33 INFO - PROCESS | 21478 | 15:51:34 INFO - PROCESS | 21478 | Cycle 1(1): loaded http://localhost:35389/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35389/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:51:35 INFO - PROCESS | 21478 | RSS: Main: 184692736 15:51:35 INFO - PROCESS | 21478 | 15:51:37 INFO - PROCESS | 21478 | Cycle 1(1): loaded http://localhost:35389/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35389/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:51:37 INFO - PROCESS | 21478 | RSS: Main: 182816768 15:51:37 INFO - PROCESS | 21478 | 15:51:40 INFO - PROCESS | 21478 | Cycle 1(1): loaded http://localhost:35389/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35389/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:51:40 INFO - PROCESS | 21478 | RSS: Main: 193642496 15:51:40 INFO - PROCESS | 21478 | 15:51:43 INFO - PROCESS | 21478 | Cycle 1(1): loaded http://localhost:35389/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:51:43 INFO - PROCESS | 21478 | RSS: Main: 199053312 15:51:43 INFO - PROCESS | 21478 | 15:51:46 INFO - PROCESS | 21478 | Cycle 1(1): loaded http://localhost:35389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:51:47 INFO - PROCESS | 21478 | RSS: Main: 198643712 15:51:47 INFO - PROCESS | 21478 | 15:51:48 INFO - PROCESS | 21478 | Cycle 1(1): loaded http://localhost:35389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35389/tests/kraken/driver.html?testName=ai-astar) 15:51:49 INFO - PROCESS | 21478 | RSS: Main: 259403776 15:51:49 INFO - PROCESS | 21478 | 15:51:49 INFO - PROCESS | 21478 | __start_tp_report 15:51:49 INFO - PROCESS | 21478 | _x_x_mozilla_page_load 15:51:49 INFO - PROCESS | 21478 | _x_x_mozilla_page_load_details 15:51:49 INFO - PROCESS | 21478 | |i|pagename|runs| 15:51:49 INFO - PROCESS | 21478 | |0;ai-astar;111;115;107;112;114;114;104;115;112;113 15:51:49 INFO - PROCESS | 21478 | |1;audio-beat-detection;163;132;152;176;132;159;159;130;179;132 15:51:49 INFO - PROCESS | 21478 | |2;audio-dft;162;162;161;162;162;161;162;163;159;161 15:51:49 INFO - PROCESS | 21478 | |3;audio-fft;97;74;75;153;74;75;73;74;151;75 15:51:49 INFO - PROCESS | 21478 | |4;audio-oscillator;97;95;138;97;96;95;157;96;95;128 15:51:49 INFO - PROCESS | 21478 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 15:51:49 INFO - PROCESS | 21478 | |6;imaging-darkroom;147;146;147;146;147;146;146;147;148;146 15:51:49 INFO - PROCESS | 21478 | |7;imaging-desaturate;95;95;96;95;95;96;96;96;96;95 15:51:49 INFO - PROCESS | 21478 | |8;json-parse-financial;67;68;69;69;68;68;69;76;67;67 15:51:49 INFO - PROCESS | 21478 | |9;json-stringify-tinderbox;70;71;71;71;71;71;71;71;70;70 15:51:49 INFO - PROCESS | 21478 | |10;stanford-crypto-aes;83;84;82;92;82;82;82;83;82;82 15:51:49 INFO - PROCESS | 21478 | |11;stanford-crypto-ccm;123;122;118;118;129;139;120;119;120;120 15:51:49 INFO - PROCESS | 21478 | |12;stanford-crypto-pbkdf2;151;135;150;147;152;140;153;148;149;140 15:51:49 INFO - PROCESS | 21478 | |13;stanford-crypto-sha256-iterative;70;71;72;74;80;70;69;72;71;72 15:51:49 INFO - PROCESS | 21478 | __end_tp_report 15:51:49 INFO - PROCESS | 21478 | __start_cc_report 15:51:49 INFO - PROCESS | 21478 | _x_x_mozilla_cycle_collect,1155 15:51:49 INFO - PROCESS | 21478 | __end_cc_report 15:51:49 INFO - PROCESS | 21478 | __startTimestamp1457567509124__endTimestamp 15:51:49 INFO - PROCESS | 21478 | 15:51:49 INFO - PROCESS | 21478 | ------- Summary: start ------- 15:51:49 INFO - PROCESS | 21478 | Number of tests: 14 15:51:49 INFO - PROCESS | 21478 | 15:51:49 INFO - PROCESS | 21478 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.50 stddev:3.59 (3.2%) stddev-sans-first:3.80 15:51:49 INFO - PROCESS | 21478 | Values: 111.0 115.0 107.0 112.0 114.0 114.0 104.0 115.0 112.0 113.0 15:51:49 INFO - PROCESS | 21478 | 15:51:49 INFO - PROCESS | 21478 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:159.00 stddev:18.87 (11.9%) stddev-sans-first:19.54 15:51:49 INFO - PROCESS | 21478 | Values: 163.0 132.0 152.0 176.0 132.0 159.0 159.0 130.0 179.0 132.0 15:51:49 INFO - PROCESS | 21478 | 15:51:49 INFO - PROCESS | 21478 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 15:51:49 INFO - PROCESS | 21478 | Values: 162.0 162.0 161.0 162.0 162.0 161.0 162.0 163.0 159.0 161.0 15:51:49 INFO - PROCESS | 21478 | 15:51:49 INFO - PROCESS | 21478 | [#3] audio-fft Cycles:10 Average:92.10 Median:74.50 stddev:32.36 (43.4%) stddev-sans-first:34.28 15:51:49 INFO - PROCESS | 21478 | Values: 97.0 74.0 75.0 153.0 74.0 75.0 73.0 74.0 151.0 75.0 15:51:49 INFO - PROCESS | 21478 | 15:51:49 INFO - PROCESS | 21478 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:95.50 stddev:22.90 (24.0%) stddev-sans-first:23.84 15:51:49 INFO - PROCESS | 21478 | Values: 97.0 95.0 138.0 97.0 96.0 95.0 157.0 96.0 95.0 128.0 15:51:49 INFO - PROCESS | 21478 | 15:51:49 INFO - PROCESS | 21478 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:51:49 INFO - PROCESS | 21478 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 15:51:49 INFO - PROCESS | 21478 | 15:51:49 INFO - PROCESS | 21478 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 15:51:49 INFO - PROCESS | 21478 | Values: 147.0 146.0 147.0 146.0 147.0 146.0 146.0 147.0 148.0 146.0 15:51:49 INFO - PROCESS | 21478 | 15:51:49 INFO - PROCESS | 21478 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:51:49 INFO - PROCESS | 21478 | Values: 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 15:51:49 INFO - PROCESS | 21478 | 15:51:49 INFO - PROCESS | 21478 | [#8] json-parse-financial Cycles:10 Average:68.80 Median:68.50 stddev:2.66 (3.9%) stddev-sans-first:2.74 15:51:49 INFO - PROCESS | 21478 | Values: 67.0 68.0 69.0 69.0 68.0 68.0 69.0 76.0 67.0 67.0 15:51:49 INFO - PROCESS | 21478 | 15:51:49 INFO - PROCESS | 21478 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:71.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 15:51:49 INFO - PROCESS | 21478 | Values: 70.0 71.0 71.0 71.0 71.0 71.0 71.0 71.0 70.0 70.0 15:51:49 INFO - PROCESS | 21478 | 15:51:49 INFO - PROCESS | 21478 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:82.50 stddev:3.10 (3.8%) stddev-sans-first:3.28 15:51:49 INFO - PROCESS | 21478 | Values: 83.0 84.0 82.0 92.0 82.0 82.0 82.0 83.0 82.0 82.0 15:51:49 INFO - PROCESS | 21478 | 15:51:49 INFO - PROCESS | 21478 | [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:121.00 stddev:6.55 (5.4%) stddev-sans-first:6.94 15:51:49 INFO - PROCESS | 21478 | Values: 123.0 122.0 118.0 118.0 129.0 139.0 120.0 119.0 120.0 120.0 15:51:49 INFO - PROCESS | 21478 | 15:51:49 INFO - PROCESS | 21478 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.50 Median:149.50 stddev:6.06 (4.1%) stddev-sans-first:6.20 15:51:49 INFO - PROCESS | 21478 | Values: 151.0 135.0 150.0 147.0 152.0 140.0 153.0 148.0 149.0 140.0 15:51:49 INFO - PROCESS | 21478 | 15:51:49 INFO - PROCESS | 21478 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.00 stddev:3.11 (4.3%) stddev-sans-first:3.20 15:51:49 INFO - PROCESS | 21478 | Values: 70.0 71.0 72.0 74.0 80.0 70.0 69.0 72.0 71.0 72.0 15:51:49 INFO - PROCESS | 21478 | -------- Summary: end -------- 15:51:49 INFO - PROCESS | 21478 | 15:51:50 INFO - TEST-INFO | 21478: exit 0 15:51:50 INFO - TEST-OK | kraken | took 62426ms 15:51:50 INFO - SUITE-END | took 1179s 15:51:50 INFO - Completed test suite (00:19:39) 15:51:50 INFO - javascript benchmark 15:51:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2557.411795287084, 2648.192301348088, 2655.203438968309, 2658.920232393029, 2683.8523881186525, 4454.599086082252, 4525.185466616008, 4536.9092618147615, 4541.7047891887005, 4570.725756454611, 4597.724136551809, 4607.124646317206, 4616.238320677085, 4630.236011058179, 4630.907381852369, 4137.234611596849, 4216.915661686772, 4256.042390462152, 4303.139372125572, 4313.202057619351, 4124.97937510312, 4238.533761286271, 4268.9114275859765, 4279.507856596485, 4293.592108749664, 4184.727992680497, 4210.705250632473, 4234.830606775725, 4240.257954857888, 4265.808038638269, 4221.978890105561, 4239.215745087169, 4246.681498887565, 4250.766207858566, 4290.76400797956, 4225.873223803291, 4232.280512312884, 4247.065645557972, 4264.808083636244, 4270.081932384521, 4378.912421751547, 4455.710378825366, 4507.323901414814, 4556.248219043854, 4556.2937744649635, 4926.753662316905, 4948.529889660476, 4949.925751113737, 4949.925751113737, 4990.326305948687, 4827.444843842968, 4950.6782059166035, 4952.306677065214, 4958.107540642683, 4959.752012399402, 4594.2419500782335, 4647.326137710081, 4680.251159814447, 4680.46174689915, 4689.390379250675, 5026.84919452417, 5056.089903817348, 5060.291559181717, 5064.442911279756, 5105.744712764347, 4723.385959825201, 4825.9758701206265, 4855.271709243641, 4855.951440485621, 4862.513748625109, 4837.975810120997, 4857.052874689472, 4857.611391088704, 4877.561019508261, 4900.2894580286375, 4822.228443449031, 4825.131476334223, 4827.734474603931, 4828.082664293773, 4865.026994601094, 4706.929396059062, 4787.42550893895, 4797.4482934462985, 4837.129316723023, 4867.026594681078, 4051.91896162081, 4054.8580799671868, 4072.7963601819793, 4081.3469844824685, 4098.7950602469755, 3584.5877724061547, 3586.9103272418397, 3601.081724160322, 3619.4027985382645, 3633.7456378053284, 4091.4067460218102, 4161.459010328698, 4205.663546916239, 4206.936895946563, 4250.702450828412, 4887.29134275528, 4928.605711543068, 4938.061768264019, 4940.1601727706375, 4956.925646115311, 4233.364995250737, 4236.110416812504, 4237.936430953539, 4266.893327666833, 4276.2516559601945, 4256.957430425656, 4332.870013899588, 4365.890852728708, 4379.277419225856, 4401.845935392246, 4668.92996605058, 4685.039566888711, 4686.742229177292, 4722.338872557844, 4729.55069268419, 4918.4097908249805, 4920.434150072644, 4922.975385123052, 4928.753562321941, 4986.252062190701, 4532.5694059064335, 4590.036092420495, 4670.906581868276, 4682.555157260055, 4689.273162659793, 4857.174280372275, 4869.0261947609915, 4871.0, 4878.341423907727, 4922.950770492393, 4908.901821963469, 4956.504349565014, 4964.801407943642, 4967.05625931072, 5017.422996355466, 4680.040591678629, 4749.548792864673, 4770.236762118045, 4792.2332426811545, 4810.254410566367, 4744.976275118603, 4761.547652972962, 4779.545943135397, 4780.545848144421, 4814.133455977958, 4567.771611419482, 4682.601978831701, 4686.8125274988615, 4690.15577196108, 4732.597729193058, 4769.856904292877, 4803.879903002453, 4806.639502037431, 4824.855254342376, 4855.514448555116, 4660.347551342747, 4698.3657206278085, 4703.412073490814, 4704.811807527797, 4749.786259618395], "unit": "score", "name": "dojo.html", "value": 4505.171151321454}, {"lowerIsBetter": false, "replicates": [499.40071913703565, 501.0155045335914, 502.16640376974226, 526.357843431014, 529.0556356902929, 25480.23559293222, 25943.091991780293, 33497.33005339892, 33756.32487350251, 33788.155296117606, 37315.58923956025, 37840.621593784126, 37856.24287514248, 37871.0, 37913.431298530544, 7639.121501027384, 7833.725819596315, 7836.255555722198, 7838.490498117632, 7841.0, 7663.501872378305, 7795.1035630902325, 7824.413169012319, 7841.647125879349, 7844.686212551491, 7969.72105976288, 8049.758507244792, 8078.1921807819335, 8078.515289082674, 8080.838383232362, 7950.363970882345, 8030.437869349148, 8039.718609848685, 8040.276375126237, 8043.477173983672, 7912.0505539335645, 8059.274665280153, 8062.798430039237, 8063.0, 8074.0, 37519.62480375189, 37865.43201851974, 37982.05044873873, 38022.23955520902, 38043.0, 2691.1242369376505, 2810.142906413543, 2810.18504633656, 2948.9262768430744, 3038.179691483287, 28405.857970710014, 28646.0, 28653.0, 28752.712472875213, 29512.26219344512, 3397.5243465914546, 3498.352804731133, 3503.194265318991, 3543.114221444639, 3601.3697602919647, 215033.0, 217269.0, 217278.0, 217624.9118754412, 217655.0, 51574.48425515697, 52908.470915291124, 53112.468875311526, 53176.0, 53187.73406133022, 56899.0, 57219.71390143106, 59938.0, 60997.39002610006, 61022.69488652617, 11740.589079382351, 11861.0, 11909.58316458937, 11910.761784764429, 11959.521619135312, 8900.376973611914, 8992.55037248148, 9000.36997410188, 9003.14470125337, 9011.143941325563, 19000.144993475325, 19007.243949627504, 19124.904375478312, 19142.521436963907, 19182.424527264204, 7334.4132469403385, 7581.696732130763, 7612.885806712904, 7641.69433222676, 7693.884591731128, 810.4893916832358, 840.932725381968, 882.4440602420434, 902.2015516268019, 914.2457472585144, 26474.6028809568, 26659.733402666112, 27027.86486067557, 27114.72885271122, 27146.185614431597, 849.4563479373206, 906.2840356118593, 972.0668158567713, 1047.36634336227, 1050.5377633841085, 11835.644930652094, 12377.133600648049, 12515.937420313023, 12588.559400420942, 12594.748105038032, 191942.0, 194496.0, 194499.02750486156, 194872.0, 194929.0, 35568.0, 35714.10714732153, 36179.27641447156, 36552.0, 36572.0, 1098.7033500954858, 1111.6553868300853, 1128.2666266926562, 1157.0, 1157.3576664950865, 23428.53142937166, 25618.975240990152, 26253.73746262513, 26756.866215668797, 26817.731822681522, 36680.81659591685, 36801.447978279815, 37034.259314814095, 37117.44323835199, 37150.814245928595, 166438.0, 167715.0, 167735.0, 167918.0, 214117.0, 28082.0, 28346.574801377585, 28352.85823570869, 28395.432091357645, 28582.14253572396, 36945.26109477849, 36978.26043479169, 37694.8115259422, 38056.80971595124, 38125.61874381221, 31219.0, 31580.526292105176, 31650.366992660478, 32324.67675323217, 32561.348773023932, 31492.527612085378, 31972.0, 32020.5196922051, 32177.356452870343, 32464.350712985135, 31769.8411507941, 31915.202119946258, 32279.0, 32284.35431291314, 32304.35391292208, 26141.346466338495, 28363.290917727223, 28589.571156432256, 28658.85670571634, 28690.282742931595, 22518.4370390735, 22887.656685149403, 22986.601462112194, 23064.308070757903, 23135.88432057829], "unit": "score", "name": "ext.html", "value": 15903.098090234205}, {"lowerIsBetter": false, "replicates": [334.9313390754896, 340.13944719858733, 341.29863131265256, 342.4982400782853, 342.7429427929053, 14484.0, 14974.176420296879, 15505.612359690986, 15580.454684086058, 15615.0, 13874.30628468575, 14227.573172804832, 14500.782488262685, 15061.0, 15191.316390762415, 4876.561109500135, 5036.6222533309965, 5042.722650254234, 5045.369328833895, 5066.037452883958, 4888.120138375091, 4890.119778439897, 4896.265560165986, 5019.54824065834, 5045.0, 4958.2562615607585, 4987.950120498803, 4990.0, 4992.875178120558, 5017.147084995559, 4958.0579689859, 4968.677035992649, 4972.87567810804, 6198.783042593487, 6510.18622672166, 6195.039768835838, 6211.720472578745, 6226.968865155645, 6231.345708700566, 6234.781782637586, 19537.0, 20759.5848083039, 21396.358109256747, 21521.0, 21534.138634454604, 1691.2220378625848, 1752.8948263104255, 1759.0325321073358, 1801.9459416217403, 1819.672458957387, 13187.472501099945, 13658.521951731742, 13744.931275343659, 14132.434702611883, 14355.928220358936, 1905.8856468611928, 1915.0999030455664, 1961.892095934723, 1992.1533348326902, 1994.222253321206, 58532.0, 59990.40009599892, 60542.69728651373, 63008.36991630117, 64194.0, 15263.771043434357, 15662.37350505967, 15664.451744188898, 15711.68576628484, 15769.526914192593, 23115.0, 23304.65043024356, 23340.76659233386, 23419.53160936806, 23443.7655623445, 7788.649510772028, 7882.605869706492, 7985.840283194304, 8021.318187954089, 8129.146439623754, 6519.282878883319, 6557.8360540985905, 6622.86754264912, 6648.301928297556, 6657.0, 7564.0, 7739.651715672809, 7753.534787912743, 7761.805954851174, 7786.0, 2883.68279489256, 2893.551499517578, 2956.659984101856, 3001.8048826826184, 3006.5790789289517, 765.6363227466909, 803.8866170354102, 823.074041703084, 862.7368652560904, 923.0584803500392, 14545.127292362493, 14747.705045899022, 15198.544043678707, 15339.079655220723, 15783.842161578466, 807.9313258372987, 814.9429539932148, 829.369679043919, 859.0121360435425, 871.7079778274349, 8543.40196186261, 8621.956890215508, 8875.245604123593, 8906.955465222762, 9107.726768196964, 379626.0, 403495.0, 411096.0, 411249.0, 412115.0, 62350.0, 64673.35326646674, 64938.67530662316, 64946.0, 65255.347446524924, 840.3655240293539, 864.4510735682886, 868.3270465389247, 870.216804875617, 877.6489404238356, 14077.648058798612, 14096.506622268582, 14411.42354305858, 14715.0, 14733.26333683333, 29007.274818129714, 30427.695723042485, 30478.542821857245, 30848.0, 31033.379332412773, 40513.79743101266, 41772.373414399415, 42423.0, 42527.787361064235, 42773.35839962465, 7090.326418990187, 7119.67961441726, 7226.421886248982, 7278.563286202845, 7343.8531229376185, 9281.535923203677, 10971.451427428756, 11043.503042362952, 11164.330140191614, 11339.433028348714, 9426.858597120912, 9571.234301256021, 9655.806883862142, 9856.605735770489, 9866.112049915542, 9494.810103797747, 9724.659636912675, 9791.706248812547, 9811.116999470081, 9857.162141218078, 9123.635054597742, 9831.459269739948, 9856.162226210565, 10048.54781534818, 10078.445685487368, 7077.68150433242, 7249.456290778318, 7258.709651613876, 7310.890336645061, 7362.5214361066355, 7665.003549538525, 9542.475163866055, 9900.702978910644, 9994.450305233282, 10090.2432317575], "unit": "score", "name": "jquery.html", "value": 8365.524202441404}, {"lowerIsBetter": false, "replicates": [1196.7666305070516, 1347.7910923806808, 1351.5202103253348, 1465.3845384938325, 1706.4880535839245, 7186.9640651796735, 7372.3364897159245, 7393.8151546211375, 7399.334059934605, 7455.217202193773, 7156.821079473016, 7292.63536823158, 7304.780856574298, 7307.159676637175, 7308.96345518273, 1842.5025243184332, 1894.0340426382575, 1897.6489349470392, 2145.8068773810355, 2181.0839447432036, 2194.045590168274, 2262.072550254396, 2263.7057182566327, 2265.716785401825, 2266.2974477911816, 2186.606410846047, 2221.822254219667, 2230.230570453199, 2232.084845213463, 2237.686723858661, 2157.2665293800183, 2161.6217161996665, 2168.7831216878344, 2169.370882444089, 2172.0443005077714, 2132.6587745960574, 2197.099189332382, 2200.273909609825, 2210.281658461007, 2218.944526386837, 7619.6571154297635, 7658.157602663702, 7665.195154508752, 7675.53946763196, 7677.73127940525, 4546.29532422475, 4645.790939407735, 4673.626109911199, 4675.158471475133, 4680.7191568506, 2829.2502486841004, 2905.3584724630514, 2920.109366643173, 2942.867570959312, 2944.1903476543907, 908.4367692030917, 912.5847739278612, 913.0914739833908, 947.5641205045687, 959.4435227567993, 10397.84403233952, 10511.106555942677, 10519.263651544396, 10529.315594486334, 10534.26260161789, 4330.0906809569715, 4338.110687309094, 4347.0871117065135, 4409.184300904279, 4412.360207769855, 8832.470051796912, 8970.237529809909, 8987.19115279628, 8990.157017811332, 8998.730038098867, 4553.817847286072, 4577.885552861138, 4601.24079526881, 4604.562566556172, 4608.6082682971655, 3468.3930312195266, 4028.7784171870244, 4130.545639979599, 4136.44158038667, 4190.622843943998, 3579.94630080549, 3602.2615363850346, 3603.657652523006, 3652.178259891556, 3654.214343916071, 1130.1015692524463, 1141.8401423800674, 1144.2848219862585, 1159.5072094359864, 1162.035510526261, 1183.071289038101, 1188.5245901639241, 1194.1939191046008, 1198.7302856857311, 1202.1825158891863, 7120.323569260912, 7131.750388736369, 7184.425245980309, 7190.784276471714, 7285.562866228043, 440.12854547995147, 451.1923656654617, 451.36357735592657, 453.98411055612894, 456.3246395334923, 5399.298091248191, 5425.321834770653, 5437.700926449083, 5439.156930675673, 5466.098093814556, 9003.14470125337, 9277.0, 9494.572744226527, 9639.759006024766, 9644.421334719938, 9339.953300233456, 9361.765955851022, 9431.104045115702, 9504.287178461644, 9519.952400237955, 6911.5853048817235, 7212.278772122746, 7216.5670059796585, 7239.5294305871, 7312.707491700273, 6880.827979300358, 6909.481788865754, 6916.861662766817, 6928.960655901655, 6942.201646810681, 8226.588670566329, 8345.874811877706, 8351.457155284887, 8369.0, 8537.146285371413, 8420.326373889951, 8690.652373905226, 8828.646854125764, 8852.203301702877, 8855.73432797017, 6550.967245163934, 6617.7683781067435, 6667.799966000834, 6670.066190733204, 6670.433013193739, 7304.780856574312, 7314.451416143704, 7345.8898116527225, 7348.3386495213545, 7348.889766653398, 6526.086347911201, 6697.330266973264, 6712.228093769279, 6778.830529236809, 6851.4176295013485, 6548.541602087808, 6586.8353291168105, 6619.040239165391, 6672.699728512326, 6677.599344039373, 6834.487413443912, 6847.383735463832, 6943.861122777617, 6945.270746571739, 6947.930520694728, 6377.266614339224, 6431.646259455775, 6476.70854811544, 6486.578372405778, 6490.3185165558825, 6458.612483250832, 6495.870082598416, 6506.934930650822, 6513.250976137615, 6522.804315870531], "unit": "score", "name": "mootools.html", "value": 4259.959540621056}, {"lowerIsBetter": false, "replicates": [309.8326903472125, 310.7871108290821, 312.3487528503071, 316.40673736743605, 317.9666135055818, 5178.275041494189, 5225.581953443725, 5245.291885595443, 5250.501202385767, 5250.579953603712, 5174.990876779029, 5200.713960732158, 5234.057869583474, 5237.214417837326, 5242.659227150232, 3901.7463864848837, 3994.840206391741, 4082.4692789937267, 4090.795460226977, 4109.506859176903, 4049.6962727795385, 4063.0654949361665, 4079.2045551117544, 4084.1831633673237, 4086.1010577672864, 4052.925974616729, 4054.939175912349, 4058.330375488056, 4091.161311931047, 4091.1817636472674, 3855.3445914194654, 3957.6042395760337, 4026.57720939303, 4040.454538637305, 4043.9595604043875, 3556.751027428081, 3558.3594952908466, 3569.39320315547, 3571.8749843755604, 3572.214112895159, 4961.950380496221, 5042.319286896259, 5043.394792624872, 5047.167217409123, 5055.140626093536, 4683.648726345504, 4687.6249900007915, 4696.342512048316, 4698.201305778026, 4704.506026867198, 5508.9724551377385, 5519.144532597454, 5521.558275337963, 5522.088855338864, 5536.307961504812, 3925.156091440354, 3928.410738389236, 3928.6857051436104, 3929.803509824526, 3936.822842972073, 5542.307211598551, 5805.3323867755325, 5808.88382232353, 5812.157237200625, 5813.796517121923, 4029.9395509066803, 4045.8381664733083, 4047.757134571876, 4050.4936882889638, 4051.9870032491876, 4105.958940410557, 4107.383892416162, 4111.671066314688, 4116.0327323079055, 4117.876463706094, 4652.3951886255245, 4663.48701642819, 4664.323673067386, 4665.3934988451965, 4671.789769460383, 5483.670979741229, 5517.668939863621, 5518.586106042063, 5519.613627046148, 5520.067976208295, 1432.298173894805, 1455.2796365798997, 1458.7228426598913, 1459.0661976335155, 1465.377214683755, 900.4687234531527, 962.9518524073768, 979.4515071559949, 994.751312171957, 1010.9191264698807, 4773.95226047742, 4782.258749893772, 4791.233402655628, 4795.472498025214, 4800.591949684246, 5609.046462101453, 5631.71841407928, 5634.605577609528, 5637.8590535236945, 5646.830595082154, 4770.785314660849, 4777.3072904429355, 4780.043991201774, 4786.425628924481, 4789.664723469394, 2993.925151871221, 3030.5454181872456, 3035.6357237131688, 3038.498647723101, 3040.0271912987632, 5350.91973620396, 5354.437784032699, 5363.088274993261, 5363.624546281723, 5364.704941228192, 5693.658380497183, 5729.713514324267, 5915.792947246826, 5916.26046744157, 5916.852078698067, 5425.430329815313, 5444.646098003617, 5447.046766815871, 5453.618246722771, 5456.508914197741, 5735.053716136791, 5740.282464691913, 5744.712764361849, 5745.6552606843725, 5750.6837123958585, 5613.438656134517, 5625.634333768292, 5631.0427227372265, 5638.971805140948, 5646.153077038312, 5448.155535891943, 5448.237246785374, 5451.754671039734, 5458.344998600193, 5463.562914966873, 3711.146436319608, 3828.2917660231833, 3833.7316387852584, 3836.76979381238, 3880.9223815524097, 5667.121596152603, 5683.431656834284, 5709.000924838219, 5709.771609135588, 5709.9714501427225, 5484.314460692413, 5497.587680924026, 5497.725113744217, 5500.834974950758, 5501.5323697486165, 5457.69982650958, 5474.288342515607, 5480.040992826319, 5480.232767412485, 5498.615096943336, 5369.301990741179, 5387.0, 5391.649542779707, 5393.622446428869, 5394.973025134849, 5349.224362467498, 5539.944600553943, 5595.300587426572, 5603.635763675348, 5604.747786349542, 5431.103867861917, 5450.672959622435, 5452.26394436746, 5456.699881506555, 5458.563314934875], "unit": "score", "name": "prototype.html", "value": 4152.145894181318}, {"lowerIsBetter": false, "replicates": [653.7025653327736, 700.9123859517559, 715.7834209887127, 736.1497470421658, 748.1844789179793, 11125.332480051193, 11201.159913006537, 11229.831552526719, 11267.718307042329, 11319.943400282997, 10971.561137554489, 10983.286086404398, 11020.614278500254, 11022.228444008922, 11028.944855275733, 603.3604379357873, 773.5358784729174, 778.1557010643459, 788.7239466186846, 790.0124843945068, 791.4143533785016, 791.9089304729972, 792.4254915186501, 794.6146119132245, 799.8080460689422, 843.5613480989881, 848.8259906719107, 849.3417601358934, 849.817289282804, 850.2220468271524, 634.3181080338609, 818.0837462042491, 836.2766207230732, 836.4479443567246, 838.5094719588986, 621.353792056261, 621.9036049412348, 622.0203179991486, 622.1849377315731, 622.3714048810689, 11930.284182949052, 11958.641240762705, 11975.0, 12006.279623222634, 12025.338606376647, 11158.609448669258, 11627.244229125165, 11641.126915481289, 11738.706532336675, 11923.0, 9569.760755981086, 9775.90224097764, 9897.4556399398, 9909.306348555603, 9946.055124763136, 3232.3696879108584, 3249.2526718854797, 3275.8034517929, 3355.597328320617, 3357.84889679965, 40176.79911600423, 40550.0, 40579.1884162318, 40632.79683601593, 40635.593644063476, 9456.669016584387, 9782.706518804447, 9837.458939758239, 9839.60641574329, 9999.0, 17342.739858902125, 17403.129843507773, 17434.738478922827, 17441.389551365643, 17455.73816392755, 6275.02737075754, 6321.747130114744, 6351.237851457855, 6392.456641185551, 6577.046328282468, 3462.23830757233, 3535.7524973251625, 3555.626659200747, 3561.5726112866623, 3563.6970857477404, 2615.5553555895544, 2655.5087308847924, 2671.2921075914896, 2676.0500022492124, 2676.7055623881356, 406.1746452148457, 474.57288440403914, 475.310799340957, 490.0884355099512, 493.27242317581283, 464.30122665389047, 534.8816400385742, 565.5673409841474, 568.8066057540374, 582.5514353947436, 7296.927030729731, 7636.647553497747, 7916.208379162038, 8000.239977202156, 8026.638801253957, 441.3313829548237, 546.66926509462, 551.8136007583727, 562.9662220266797, 578.3291381996863, 3630.5643322801434, 3640.9453858192146, 3645.526081609427, 3666.944995825065, 3774.6225377462033, 46064.53935460602, 48285.75857120692, 48389.0, 48576.75711621419, 48775.756121219165, 42187.0, 42522.57477425248, 42684.0, 42819.78590107092, 43467.34798978018, 38825.22349552993, 39697.404538931936, 39971.20057598832, 40061.198776024314, 40175.59824401777, 8138.593070346577, 8262.873568915054, 8280.0, 8467.258335332233, 8475.364347673825, 30136.698633013388, 30863.0, 31329.8433507831, 31345.373092537564, 31535.526967095055, 33882.49176262309, 34148.31703365968, 34237.486437703956, 37626.0, 38969.0, 9665.598488219028, 9871.65449209303, 10093.5457904393, 10195.082442580204, 10543.420111893613, 10423.895761042293, 10433.634822781167, 10468.0, 10620.628278010232, 11903.345316007357, 10603.469826508797, 10948.178886583697, 10994.450277486254, 11307.038901693448, 11390.316581005167, 9965.60137594517, 10136.391816491034, 10328.211382926718, 10641.627543035956, 10712.678619641423, 9775.657851975147, 10094.293399461967, 10128.189744820544, 10214.693559193236, 10475.738106547396, 8664.220220180214, 8906.554672266231, 8916.73249802507, 9079.591418386057, 9154.862677059717, 8479.915200847912, 8653.783655408664, 8879.778005549913, 9203.40177888435, 9589.0], "unit": "score", "name": "yui.html", "value": 5653.991464500403}], "name": "dromaeo_css", "value": 6255.955390558046}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 115.0, 107.0, 112.0, 114.0, 114.0, 104.0, 115.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [163.0, 132.0, 152.0, 176.0, 132.0, 159.0, 159.0, 130.0, 179.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 151.4}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 162.0, 162.0, 161.0, 162.0, 163.0, 159.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [97.0, 74.0, 75.0, 153.0, 74.0, 75.0, 73.0, 74.0, 151.0, 75.0], "unit": "score", "name": "audio-fft", "value": 92.1}, {"lowerIsBetter": true, "replicates": [97.0, 95.0, 138.0, 97.0, 96.0, 95.0, 157.0, 96.0, 95.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 69.0, 68.0, 68.0, 69.0, 76.0, 67.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 68.8}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 71.0, 71.0, 71.0, 71.0, 71.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.7}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 82.0, 92.0, 82.0, 82.0, 82.0, 83.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [123.0, 122.0, 118.0, 118.0, 129.0, 139.0, 120.0, 119.0, 120.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.8}, {"lowerIsBetter": true, "replicates": [151.0, 135.0, 150.0, 147.0, 152.0, 140.0, 153.0, 148.0, 149.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.5}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 72.0, 74.0, 80.0, 70.0, 69.0, 72.0, 71.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.1}], "name": "kraken", "value": 1549.4}]} 15:51:50 INFO - Return code: 0 15:51:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:51:50 ERROR - # TBPL SUCCESS # 15:51:50 INFO - Running post-action listener: _resource_record_post_action 15:51:50 INFO - Running post-run listener: _resource_record_post_run 15:51:51 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 527552512; Read time: 0; Write time: 742072 15:51:51 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 244641792; Read time: 0; Write time: 480836 15:51:51 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 282447872; Read time: 0; Write time: 261236 15:51:51 INFO - Running post-run listener: _upload_blobber_files 15:51:51 INFO - Blob upload gear active. 15:51:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:51:51 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 15:51:51 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'] 15:51:51 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 15:51:51 INFO - (blobuploader) - INFO - Open directory for files ... 15:51:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:51:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:51:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:52 INFO - (blobuploader) - INFO - Done attempting. 15:51:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:51:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:51:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:53 INFO - (blobuploader) - INFO - Done attempting. 15:51:53 INFO - (blobuploader) - INFO - Iteration through files over. 15:51:53 INFO - Return code: 0 15:51:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:51:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:51:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cb8c6bdb9040702e44e851e2ccb5134e48894676020a4572ea5520413b8010e1ecfb3266d473bf2fddf2c5cd49cc3c8be04f53fb631c85a0bd2b56e8270a8b84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d7923e4f6bb4b93d84e313c4500785df57b1e2a33b686b2174b4f738a24d9a20969302f9accd01847fb8aceaad67f75ed01a3512a6236b167d75a373cc15f5da"} 15:51:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:51:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:51:53 INFO - Contents: 15:51:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cb8c6bdb9040702e44e851e2ccb5134e48894676020a4572ea5520413b8010e1ecfb3266d473bf2fddf2c5cd49cc3c8be04f53fb631c85a0bd2b56e8270a8b84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d7923e4f6bb4b93d84e313c4500785df57b1e2a33b686b2174b4f738a24d9a20969302f9accd01847fb8aceaad67f75ed01a3512a6236b167d75a373cc15f5da"} 15:51:53 INFO - Running post-run listener: copy_logs_to_upload_dir 15:51:53 INFO - Copying logs to upload dir... 15:51:53 INFO - mkdir: /builds/slave/test/build/upload/logs 15:51:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.671750 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-03-09 15:51:52.536240) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 15:51:52.540144) ========= 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=cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859 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/cb8c6bdb9040702e44e851e2ccb5134e48894676020a4572ea5520413b8010e1ecfb3266d473bf2fddf2c5cd49cc3c8be04f53fb631c85a0bd2b56e8270a8b84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d7923e4f6bb4b93d84e313c4500785df57b1e2a33b686b2174b4f738a24d9a20969302f9accd01847fb8aceaad67f75ed01a3512a6236b167d75a373cc15f5da"} build_url:https://queue.taskcluster.net/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/AyxcuoncS_-_ZZc6jp0BDQ/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/cb8c6bdb9040702e44e851e2ccb5134e48894676020a4572ea5520413b8010e1ecfb3266d473bf2fddf2c5cd49cc3c8be04f53fb631c85a0bd2b56e8270a8b84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d7923e4f6bb4b93d84e313c4500785df57b1e2a33b686b2174b4f738a24d9a20969302f9accd01847fb8aceaad67f75ed01a3512a6236b167d75a373cc15f5da"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 15:51:52.570493) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 15:51:52.571351) ========= 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=cbe409c6de289db6ac707de3000001d4-1457566210.603488-1202302859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 15:51:52.653508) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 15:51:52.654117) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 15:51:52.654684) ========= ========= Total master_lag: 0.29 =========