builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1457572238.41 results: success (0) buildid: 20160309162727 builduid: 90ca3250ccc0404cbd55735bc7241a23 revision: 5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 17:10:38.405791) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 17:10:38.406307) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 17:10:38.406637) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005643 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 17:10:38.426399) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 17:10:38.426734) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 17:10:38.437314) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 17:10:38.437639) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004695 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 17:10:38.489639) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 17:10:38.490067) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 17:10:38.490570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 17:10:38.490973) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-09 17:10:39-- 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% 39.8M=0s 2016-03-09 17:10:39 (39.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162582 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 17:10:38.666875) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 17:10:38.667252) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017985 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 17:10:38.717165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 17:10:38.717577) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e --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 5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e --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=8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-09 17:10:39,310 truncating revision to first 12 chars 2016-03-09 17:10:39,310 Setting DEBUG logging. 2016-03-09 17:10:39,310 attempt 1/10 2016-03-09 17:10:39,310 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5c3790398ff5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-09 17:10:40,068 unpacking tar archive at: fx-team-5c3790398ff5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.960184 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 17:10:40.694488) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 17:10:40.695369) ========= echo 5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e'] 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=8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e program finished with exit code 0 elapsedTime=0.004735 script_repo_revision: '5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 17:10:40.749232) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 17:10:40.749732) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 17:10:40.760716) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-09 17:10:40.761050) ========= /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=8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:10:41 INFO - MultiFileLogger online at 20160309 17:10:41 in /builds/slave/test 17:10:41 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 17:10:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:10:41 INFO - {'append_to_log': False, 17:10:41 INFO - 'base_work_dir': '/builds/slave/test', 17:10:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:10:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:10:41 INFO - 'branch': 'Fx-Team-Non-PGO', 17:10:41 INFO - 'buildbot_json_path': 'buildprops.json', 17:10:41 INFO - 'config_files': ('talos/linux_config.py',), 17:10:41 INFO - 'default_actions': ('clobber', 17:10:41 INFO - 'read-buildbot-config', 17:10:41 INFO - 'download-and-extract', 17:10:41 INFO - 'populate-webroot', 17:10:41 INFO - 'create-virtualenv', 17:10:41 INFO - 'install', 17:10:41 INFO - 'run-tests'), 17:10:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:10:41 INFO - 'download_minidump_stackwalk': True, 17:10:41 INFO - 'download_symbols': 'ondemand', 17:10:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:10:41 INFO - 'tooltool.py': '/tools/tooltool.py', 17:10:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:10:41 INFO - '/tools/misc-python/virtualenv.py')}, 17:10:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:10:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:10:41 INFO - 'installer_path': 'installer.exe', 17:10:41 INFO - 'log_level': 'info', 17:10:41 INFO - 'log_name': 'talos', 17:10:41 INFO - 'log_to_console': True, 17:10:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:10:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:10:41 INFO - 'opt_config_files': (), 17:10:41 INFO - 'pip_index': False, 17:10:41 INFO - 'sps_profile': False, 17:10:41 INFO - 'sps_profile_interval': 0, 17:10:41 INFO - 'suite': 'dromaeojs', 17:10:41 INFO - 'system_bits': '32', 17:10:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:10:41 INFO - 'title': 'talos-linux64-ix-049', 17:10:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:10:41 INFO - 'use_talos_json': True, 17:10:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:10:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:10:41 INFO - 'work_dir': 'build'} 17:10:41 INFO - ##### 17:10:41 INFO - ##### Running clobber step. 17:10:41 INFO - ##### 17:10:41 INFO - Running pre-action listener: _resource_record_pre_action 17:10:41 INFO - Running main action method: clobber 17:10:41 INFO - rmtree: /builds/slave/test/build 17:10:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:10:42 INFO - Running post-action listener: _resource_record_post_action 17:10:42 INFO - ##### 17:10:42 INFO - ##### Running read-buildbot-config step. 17:10:42 INFO - ##### 17:10:42 INFO - Running pre-action listener: _resource_record_pre_action 17:10:42 INFO - Running main action method: read_buildbot_config 17:10:42 INFO - Using buildbot properties: 17:10:42 INFO - { 17:10:42 INFO - "project": "", 17:10:42 INFO - "product": "firefox", 17:10:42 INFO - "script_repo_revision": "production", 17:10:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:10:42 INFO - "repository": "", 17:10:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:10:42 INFO - "buildid": "20160309162727", 17:10:42 INFO - "pgo_build": "False", 17:10:42 INFO - "basedir": "/builds/slave/test", 17:10:42 INFO - "buildnumber": 1426, 17:10:42 INFO - "slavename": "talos-linux64-ix-049", 17:10:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:10:42 INFO - "platform": "ubuntu64_hw", 17:10:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:10:42 INFO - "branch": "fx-team", 17:10:42 INFO - "repo_path": "integration/fx-team", 17:10:42 INFO - "revision": "5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e", 17:10:42 INFO - "stage_platform": "linux64", 17:10:42 INFO - "builduid": "90ca3250ccc0404cbd55735bc7241a23", 17:10:42 INFO - "slavebuilddir": "test" 17:10:42 INFO - } 17:10:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:10:42 INFO - Running post-action listener: _resource_record_post_action 17:10:42 INFO - ##### 17:10:42 INFO - ##### Running download-and-extract step. 17:10:42 INFO - ##### 17:10:42 INFO - Running pre-action listener: _resource_record_pre_action 17:10:42 INFO - Running main action method: download_and_extract 17:10:42 INFO - mkdir: /builds/slave/test/build/tests 17:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:42 INFO - https://queue.taskcluster.net/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:10:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:10:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:10:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/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 17:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/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 17:10:44 INFO - Downloaded 1361 bytes. 17:10:44 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:10:44 INFO - Using the following test package requirements: 17:10:44 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:10:44 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:10:44 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:10:44 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:44 INFO - u'jsshell-linux-x86_64.zip'], 17:10:44 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:10:44 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:10:44 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:10:44 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:10:44 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:10:44 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:10:44 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:10: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')]} 17:10:44 INFO - https://queue.taskcluster.net/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:10:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:10:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:10:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/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 17:10:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/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 17:10:45 INFO - Downloaded 22091896 bytes. 17:10:45 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'] 17:10:45 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 17:10:46 INFO - Return code: 0 17:10:46 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 17:10:46 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')]} 17:10:46 INFO - https://queue.taskcluster.net/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:10:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:10:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:10:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/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 17:10:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/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 17:10:47 INFO - Downloaded 22091896 bytes. 17:10:47 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'] 17:10:47 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 17:10:48 INFO - Return code: 0 17:10: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')]} 17:10:48 INFO - https://queue.taskcluster.net/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:10:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:10:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:10:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/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 17:10:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/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 17:10:49 INFO - Downloaded 10845161 bytes. 17:10:49 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'] 17:10:49 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 17:10:49 INFO - Return code: 0 17:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:49 INFO - https://queue.taskcluster.net/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:10:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:10:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:10:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/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 17:10:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SqkwYjSKT6mUVaN3w2bSQw/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 17:10:51 INFO - Downloaded 54419801 bytes. 17:10:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:10:51 INFO - mkdir: /builds/slave/test/properties 17:10:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:10:51 INFO - Writing to file /builds/slave/test/properties/build_url 17:10:51 INFO - Contents: 17:10:51 INFO - build_url:https://queue.taskcluster.net/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:10:51 INFO - Running post-action listener: _resource_record_post_action 17:10:51 INFO - Running post-action listener: set_extra_try_arguments 17:10:51 INFO - ##### 17:10:51 INFO - ##### Running populate-webroot step. 17:10:51 INFO - ##### 17:10:51 INFO - Running pre-action listener: _resource_record_pre_action 17:10:51 INFO - Running main action method: populate_webroot 17:10:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:10:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:10:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:10:51 INFO - '--tppagecycles', 17:10:51 INFO - '7'], 17:10:51 INFO - 'tests': ['tsvgm']}}, 17:10:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:10:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:10:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:10:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:10:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:10:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:10:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:10:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:51 INFO - 'talos_options': ['--e10s'], 17:10:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:10:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:51 INFO - 'tests': ['damp', 'tps']}, 17:10:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:51 INFO - 'talos_options': ['--e10s'], 17:10:51 INFO - 'tests': ['damp', 'tps']}, 17:10:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:10:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:10:51 INFO - 'other': {'tests': ['a11yr', 17:10:51 INFO - 'ts_paint', 17:10:51 INFO - 'tpaint', 17:10:51 INFO - 'sessionrestore', 17:10:51 INFO - 'sessionrestore_no_auto_restore', 17:10:51 INFO - 'tabpaint']}, 17:10:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:10:51 INFO - 'tests': ['a11yr', 17:10:51 INFO - 'ts_paint', 17:10:51 INFO - 'tpaint', 17:10:51 INFO - 'sessionrestore', 17:10:51 INFO - 'sessionrestore_no_auto_restore', 17:10:51 INFO - 'tabpaint']}, 17:10:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:10:51 INFO - 'tests': ['a11yr', 17:10:51 INFO - 'ts_paint', 17:10:51 INFO - 'tpaint', 17:10:51 INFO - 'sessionrestore', 17:10:51 INFO - 'sessionrestore_no_auto_restore', 17:10:51 INFO - 'tabpaint']}, 17:10:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:10:51 INFO - 'tests': ['a11yr', 17:10:51 INFO - 'ts_paint', 17:10:51 INFO - 'tpaint', 17:10:51 INFO - 'sessionrestore', 17:10:51 INFO - 'sessionrestore_no_auto_restore', 17:10:51 INFO - 'tabpaint']}, 17:10:51 INFO - 'other_l64': {'tests': ['a11yr', 17:10:51 INFO - 'ts_paint', 17:10:51 INFO - 'tpaint', 17:10:51 INFO - 'sessionrestore', 17:10:51 INFO - 'sessionrestore_no_auto_restore', 17:10:51 INFO - 'tabpaint']}, 17:10:51 INFO - 'other_nol64': {'tests': ['a11yr', 17:10:51 INFO - 'ts_paint', 17:10:51 INFO - 'tpaint', 17:10:51 INFO - 'sessionrestore', 17:10:51 INFO - 'sessionrestore_no_auto_restore', 17:10:51 INFO - 'tabpaint']}, 17:10:51 INFO - 'svgr': {'tests': ['tsvgx', 17:10:51 INFO - 'tsvgr_opacity', 17:10:51 INFO - 'tart', 17:10:51 INFO - 'tscrollx', 17:10:51 INFO - 'cart']}, 17:10:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:10:51 INFO - 'tests': ['tsvgx', 17:10:51 INFO - 'tsvgr_opacity', 17:10:51 INFO - 'tart', 17:10:51 INFO - 'tscrollx', 17:10:51 INFO - 'cart']}, 17:10:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:51 INFO - 'tests': ['tp5o']}, 17:10:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:51 INFO - 'talos_options': ['--e10s'], 17:10:51 INFO - 'tests': ['tp5o']}, 17:10:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:51 INFO - 'talos_options': ['--xperf_path', 17:10:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:10:51 INFO - 'tests': ['tp5n']}, 17:10:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:51 INFO - 'talos_options': ['--e10s', 17:10:51 INFO - '--xperf_path', 17:10:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:10:51 INFO - 'tests': ['tp5n']}}, 17:10:51 INFO - 'talos.zip': {'path': '', 17:10:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:10:51 INFO - Running post-action listener: _resource_record_post_action 17:10:51 INFO - ##### 17:10:51 INFO - ##### Running create-virtualenv step. 17:10:51 INFO - ##### 17:10:51 INFO - Running pre-action listener: _resource_record_pre_action 17:10:51 INFO - Running main action method: create_virtualenv 17:10:51 INFO - Creating virtualenv /builds/slave/test/build/venv 17:10:51 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 17:10:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:10:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:10:51 INFO - Using real prefix '/usr' 17:10:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:10:52 INFO - Installing distribute.............................................................................................................................................................................................done. 17:10:54 INFO - Installing pip.................done. 17:10:54 INFO - Return code: 0 17:10:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:54 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 0x7fe97fb81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b580>, '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 0x1e2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c910>, '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': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', '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 17:10:54 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 17:10:54 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 17:10:54 INFO - Using env: {'DISPLAY': ':0', 17:10:54 INFO - 'HOME': '/home/cltbld', 17:10:54 INFO - 'LANG': 'en_US.UTF-8', 17:10:54 INFO - 'LANGUAGE': 'en_US:en', 17:10:54 INFO - 'LOGNAME': 'cltbld', 17:10:54 INFO - 'MAIL': '/var/mail/cltbld', 17:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:54 INFO - 'MOZ_NO_REMOTE': '1', 17:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:54 INFO - 'NO_EM_RESTART': '1', 17:10:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:54 INFO - 'PWD': '/builds/slave/test', 17:10:54 INFO - 'SHELL': '/bin/bash', 17:10:54 INFO - 'SHLVL': '1', 17:10:54 INFO - 'TERM': 'linux', 17:10:54 INFO - 'TMOUT': '86400', 17:10:54 INFO - 'USER': 'cltbld', 17:10:54 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', 17:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:54 INFO - '_': '/tools/buildbot/bin/python'} 17:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:54 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 17:10:54 INFO - Cleaning up... 17:10:54 INFO - Return code: 0 17:10:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:54 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 0x7fe97fb81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b580>, '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 0x1e2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c910>, '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': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', '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 17:10:54 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 17:10:54 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 17:10:54 INFO - Using env: {'DISPLAY': ':0', 17:10:54 INFO - 'HOME': '/home/cltbld', 17:10:54 INFO - 'LANG': 'en_US.UTF-8', 17:10:54 INFO - 'LANGUAGE': 'en_US:en', 17:10:54 INFO - 'LOGNAME': 'cltbld', 17:10:54 INFO - 'MAIL': '/var/mail/cltbld', 17:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:54 INFO - 'MOZ_NO_REMOTE': '1', 17:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:54 INFO - 'NO_EM_RESTART': '1', 17:10:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:54 INFO - 'PWD': '/builds/slave/test', 17:10:54 INFO - 'SHELL': '/bin/bash', 17:10:54 INFO - 'SHLVL': '1', 17:10:54 INFO - 'TERM': 'linux', 17:10:54 INFO - 'TMOUT': '86400', 17:10:54 INFO - 'USER': 'cltbld', 17:10:54 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', 17:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:54 INFO - '_': '/tools/buildbot/bin/python'} 17:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:54 INFO - Downloading/unpacking psutil>=0.7.1 17:10:54 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 17:10:54 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 17:10:54 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 17:10:54 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 17:10:54 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 17:10:54 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 17:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:10:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:56 INFO - Installing collected packages: psutil 17:10:56 INFO - Running setup.py install for psutil 17:10:56 INFO - building 'psutil._psutil_linux' extension 17:10:56 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 17:10:56 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 17:10:56 INFO - building 'psutil._psutil_posix' extension 17:10:56 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 17:10:57 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 17:10:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:57 INFO - Successfully installed psutil 17:10:57 INFO - Cleaning up... 17:10:57 INFO - Return code: 0 17:10:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:10:57 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')]} 17:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:57 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')]} 17:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:57 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 0x7fe97fb81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b580>, '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 0x1e2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c910>, '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': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', '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 17:10:57 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 17:10:57 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 17:10:57 INFO - Using env: {'DISPLAY': ':0', 17:10:57 INFO - 'HOME': '/home/cltbld', 17:10:57 INFO - 'LANG': 'en_US.UTF-8', 17:10:57 INFO - 'LANGUAGE': 'en_US:en', 17:10:57 INFO - 'LOGNAME': 'cltbld', 17:10:57 INFO - 'MAIL': '/var/mail/cltbld', 17:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:57 INFO - 'MOZ_NO_REMOTE': '1', 17:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:57 INFO - 'NO_EM_RESTART': '1', 17:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:57 INFO - 'PWD': '/builds/slave/test', 17:10:57 INFO - 'SHELL': '/bin/bash', 17:10:57 INFO - 'SHLVL': '1', 17:10:57 INFO - 'TERM': 'linux', 17:10:57 INFO - 'TMOUT': '86400', 17:10:57 INFO - 'USER': 'cltbld', 17:10:57 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', 17:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:57 INFO - '_': '/tools/buildbot/bin/python'} 17:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:10:57 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 17:10:57 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 17:10:57 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 17:10:57 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 17:10:57 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 17:10:57 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 17:10:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:10:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:10:59 INFO - Installing collected packages: mozsystemmonitor 17:10:59 INFO - Running setup.py install for mozsystemmonitor 17:10:59 INFO - Successfully installed mozsystemmonitor 17:10:59 INFO - Cleaning up... 17:10:59 INFO - Return code: 0 17:10:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:59 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 0x7fe97fb81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b580>, '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 0x1e2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c910>, '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': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', '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 17:10:59 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 17:10:59 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 17:10:59 INFO - Using env: {'DISPLAY': ':0', 17:10:59 INFO - 'HOME': '/home/cltbld', 17:10:59 INFO - 'LANG': 'en_US.UTF-8', 17:10:59 INFO - 'LANGUAGE': 'en_US:en', 17:10:59 INFO - 'LOGNAME': 'cltbld', 17:10:59 INFO - 'MAIL': '/var/mail/cltbld', 17:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:59 INFO - 'MOZ_NO_REMOTE': '1', 17:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:59 INFO - 'NO_EM_RESTART': '1', 17:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:59 INFO - 'PWD': '/builds/slave/test', 17:10:59 INFO - 'SHELL': '/bin/bash', 17:10:59 INFO - 'SHLVL': '1', 17:10:59 INFO - 'TERM': 'linux', 17:10:59 INFO - 'TMOUT': '86400', 17:10:59 INFO - 'USER': 'cltbld', 17:10:59 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', 17:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:59 INFO - '_': '/tools/buildbot/bin/python'} 17:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:59 INFO - Downloading/unpacking blobuploader==1.2.4 17:10:59 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 17:10:59 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 17:10:59 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 17:10:59 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 17:10:59 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 17:10:59 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 17:11:01 INFO - Downloading blobuploader-1.2.4.tar.gz 17:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:11:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:11:01 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 17:11:01 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 17:11:01 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 17:11:01 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 17:11:01 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 17:11:01 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 17:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:11:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:11:02 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 17:11:02 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 17:11:02 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 17:11:02 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 17:11:02 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 17:11:02 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 17:11:02 INFO - Downloading docopt-0.6.1.tar.gz 17:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:11:02 INFO - Installing collected packages: blobuploader, requests, docopt 17:11:02 INFO - Running setup.py install for blobuploader 17:11:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:11:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:11:02 INFO - Running setup.py install for requests 17:11:03 INFO - Running setup.py install for docopt 17:11:03 INFO - Successfully installed blobuploader requests docopt 17:11:03 INFO - Cleaning up... 17:11:03 INFO - Return code: 0 17:11:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:03 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 0x7fe97fb81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b580>, '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 0x1e2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c910>, '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': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', '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 17:11:03 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 17:11:03 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 17:11:03 INFO - Using env: {'DISPLAY': ':0', 17:11:03 INFO - 'HOME': '/home/cltbld', 17:11:03 INFO - 'LANG': 'en_US.UTF-8', 17:11:03 INFO - 'LANGUAGE': 'en_US:en', 17:11:03 INFO - 'LOGNAME': 'cltbld', 17:11:03 INFO - 'MAIL': '/var/mail/cltbld', 17:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:03 INFO - 'MOZ_NO_REMOTE': '1', 17:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:03 INFO - 'NO_EM_RESTART': '1', 17:11:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:03 INFO - 'PWD': '/builds/slave/test', 17:11:03 INFO - 'SHELL': '/bin/bash', 17:11:03 INFO - 'SHLVL': '1', 17:11:03 INFO - 'TERM': 'linux', 17:11:03 INFO - 'TMOUT': '86400', 17:11:03 INFO - 'USER': 'cltbld', 17:11:03 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', 17:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:03 INFO - '_': '/tools/buildbot/bin/python'} 17:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:11:03 INFO - Running setup.py (path:/tmp/pip-mL8j2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:11:03 INFO - Running setup.py (path:/tmp/pip-us16Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:11:03 INFO - Running setup.py (path:/tmp/pip-zoQ3xQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:11:03 INFO - Running setup.py (path:/tmp/pip-Fl5wsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:11:03 INFO - Running setup.py (path:/tmp/pip-ESyDW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:11:03 INFO - Running setup.py (path:/tmp/pip-YGQTpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:11:03 INFO - Running setup.py (path:/tmp/pip-U6M4ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:11:03 INFO - Running setup.py (path:/tmp/pip-lBEadW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:11:04 INFO - Running setup.py (path:/tmp/pip-0BCrwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:11:04 INFO - Running setup.py (path:/tmp/pip-DisVY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:11:04 INFO - Running setup.py (path:/tmp/pip-VyCW3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:11:04 INFO - Running setup.py (path:/tmp/pip-cN3y4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:11:04 INFO - Running setup.py (path:/tmp/pip-tmPq47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:11:04 INFO - Running setup.py (path:/tmp/pip-aJFZ43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:04 INFO - Running setup.py (path:/tmp/pip-55vxpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:11:04 INFO - Running setup.py (path:/tmp/pip-k2NKx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:11:04 INFO - Running setup.py (path:/tmp/pip-61iDRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:11:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:11:04 INFO - Running setup.py install for manifestparser 17:11:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:11:04 INFO - Running setup.py install for mozcrash 17:11:04 INFO - Running setup.py install for mozdebug 17:11:04 INFO - Running setup.py install for mozdevice 17:11:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:11:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:11:05 INFO - Running setup.py install for mozfile 17:11:05 INFO - Running setup.py install for mozhttpd 17:11:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:11:05 INFO - Running setup.py install for mozinfo 17:11:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:11:05 INFO - Running setup.py install for mozInstall 17:11:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:11:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:11:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:11:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:11:05 INFO - Running setup.py install for mozleak 17:11:05 INFO - Running setup.py install for mozlog 17:11:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:11:05 INFO - Running setup.py install for moznetwork 17:11:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:11:05 INFO - Running setup.py install for mozprocess 17:11:05 INFO - Running setup.py install for mozprofile 17:11:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:11:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:11:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:11:06 INFO - Running setup.py install for mozrunner 17:11:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:11:06 INFO - Running setup.py install for mozscreenshot 17:11:06 INFO - Running setup.py install for moztest 17:11:06 INFO - Running setup.py install for mozversion 17:11:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:11:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:11:06 INFO - Cleaning up... 17:11:06 INFO - Return code: 0 17:11:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11: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')]} 17:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11: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')]} 17:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:06 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 0x7fe97fb81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b580>, '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 0x1e2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c910>, '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': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', '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 17:11:06 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 17:11:06 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 17:11:06 INFO - Using env: {'DISPLAY': ':0', 17:11:06 INFO - 'HOME': '/home/cltbld', 17:11:06 INFO - 'LANG': 'en_US.UTF-8', 17:11:06 INFO - 'LANGUAGE': 'en_US:en', 17:11:06 INFO - 'LOGNAME': 'cltbld', 17:11:06 INFO - 'MAIL': '/var/mail/cltbld', 17:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:06 INFO - 'MOZ_NO_REMOTE': '1', 17:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:06 INFO - 'NO_EM_RESTART': '1', 17:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:06 INFO - 'PWD': '/builds/slave/test', 17:11:06 INFO - 'SHELL': '/bin/bash', 17:11:06 INFO - 'SHLVL': '1', 17:11:06 INFO - 'TERM': 'linux', 17:11:06 INFO - 'TMOUT': '86400', 17:11:06 INFO - 'USER': 'cltbld', 17:11:06 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', 17:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:06 INFO - '_': '/tools/buildbot/bin/python'} 17:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:11:06 INFO - Running setup.py (path:/tmp/pip-RBcOBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:11:06 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)) 17:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:11:06 INFO - Running setup.py (path:/tmp/pip-soHbZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:11:06 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)) 17:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:11:06 INFO - Running setup.py (path:/tmp/pip-G3Awhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:11:06 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)) 17:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:11:06 INFO - Running setup.py (path:/tmp/pip-Mv4IPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:11:06 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)) 17:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:11:06 INFO - Running setup.py (path:/tmp/pip-RIm3y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:11:07 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)) 17:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:11:07 INFO - Running setup.py (path:/tmp/pip-zEwdNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:11:07 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)) 17:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:11:07 INFO - Running setup.py (path:/tmp/pip-WTN4_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:11:07 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)) 17:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:11:07 INFO - Running setup.py (path:/tmp/pip-P4QV0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:11:07 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)) 17:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:11:07 INFO - Running setup.py (path:/tmp/pip-fYU8sI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:11:07 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)) 17:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:11:07 INFO - Running setup.py (path:/tmp/pip-FmDwx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:11:07 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)) 17:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:11:07 INFO - Running setup.py (path:/tmp/pip-lvG2Op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:11:07 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)) 17:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:11:07 INFO - Running setup.py (path:/tmp/pip-z6ilAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:11:07 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)) 17:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:11:07 INFO - Running setup.py (path:/tmp/pip-Xd0dPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:11:07 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)) 17:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:11:07 INFO - Running setup.py (path:/tmp/pip-wOgzfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:11:07 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)) 17:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:07 INFO - Running setup.py (path:/tmp/pip-zEM577-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:07 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)) 17:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:11:07 INFO - Running setup.py (path:/tmp/pip-b61mkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:11:07 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)) 17:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:11:07 INFO - Running setup.py (path:/tmp/pip-19nZo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:11:07 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)) 17:11:07 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)) 17:11:07 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)) 17:11:07 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)) 17:11:07 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)) 17:11:07 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)) 17:11:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:09 INFO - Downloading blessings-1.6.tar.gz 17:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:11:09 INFO - Installing collected packages: blessings 17:11:09 INFO - Running setup.py install for blessings 17:11:09 INFO - Successfully installed blessings 17:11:09 INFO - Cleaning up... 17:11:09 INFO - Return code: 0 17:11:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:11:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:11:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:11:10 INFO - Reading from file tmpfile_stdout 17:11:10 INFO - Current package versions: 17:11:10 INFO - argparse == 1.2.1 17:11:10 INFO - blessings == 1.6 17:11:10 INFO - blobuploader == 1.2.4 17:11:10 INFO - docopt == 0.6.1 17:11:10 INFO - manifestparser == 1.1 17:11:10 INFO - mozInstall == 1.12 17:11:10 INFO - mozcrash == 0.17 17:11:10 INFO - mozdebug == 0.1 17:11:10 INFO - mozdevice == 0.48 17:11:10 INFO - mozfile == 1.2 17:11:10 INFO - mozhttpd == 0.7 17:11:10 INFO - mozinfo == 0.9 17:11:10 INFO - mozleak == 0.1 17:11:10 INFO - mozlog == 3.1 17:11:10 INFO - moznetwork == 0.27 17:11:10 INFO - mozprocess == 0.22 17:11:10 INFO - mozprofile == 0.28 17:11:10 INFO - mozrunner == 6.11 17:11:10 INFO - mozscreenshot == 0.1 17:11:10 INFO - mozsystemmonitor == 0.0 17:11:10 INFO - moztest == 0.7 17:11:10 INFO - mozversion == 1.4 17:11:10 INFO - psutil == 3.1.1 17:11:10 INFO - requests == 1.2.3 17:11:10 INFO - wsgiref == 0.1.2 17:11:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:10 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')]} 17:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:10 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')]} 17:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:10 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 0x7fe97fb81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b580>, '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 0x1e2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c910>, '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': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', '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 17:11:10 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 17:11:10 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 17:11:10 INFO - Using env: {'DISPLAY': ':0', 17:11:10 INFO - 'HOME': '/home/cltbld', 17:11:10 INFO - 'LANG': 'en_US.UTF-8', 17:11:10 INFO - 'LANGUAGE': 'en_US:en', 17:11:10 INFO - 'LOGNAME': 'cltbld', 17:11:10 INFO - 'MAIL': '/var/mail/cltbld', 17:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:10 INFO - 'MOZ_NO_REMOTE': '1', 17:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:10 INFO - 'NO_EM_RESTART': '1', 17:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:10 INFO - 'PWD': '/builds/slave/test', 17:11:10 INFO - 'SHELL': '/bin/bash', 17:11:10 INFO - 'SHLVL': '1', 17:11:10 INFO - 'TERM': 'linux', 17:11:10 INFO - 'TMOUT': '86400', 17:11:10 INFO - 'USER': 'cltbld', 17:11:10 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', 17:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:10 INFO - '_': '/tools/buildbot/bin/python'} 17:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:10 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)) 17:11:10 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)) 17:11:10 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)) 17:11:10 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)) 17:11:10 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)) 17:11:10 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)) 17:11:10 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)) 17:11:10 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)) 17:11:10 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)) 17:11:10 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)) 17:11:10 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)) 17:11:10 INFO - Cleaning up... 17:11:10 INFO - Return code: 0 17:11:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:11:10 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')]} 17:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:10 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')]} 17:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:10 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 0x7fe97fb81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b580>, '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 0x1e2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c910>, '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': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', '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 17:11:10 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 17:11:10 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 17:11:10 INFO - Using env: {'DISPLAY': ':0', 17:11:10 INFO - 'HOME': '/home/cltbld', 17:11:10 INFO - 'LANG': 'en_US.UTF-8', 17:11:10 INFO - 'LANGUAGE': 'en_US:en', 17:11:10 INFO - 'LOGNAME': 'cltbld', 17:11:10 INFO - 'MAIL': '/var/mail/cltbld', 17:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:10 INFO - 'MOZ_NO_REMOTE': '1', 17:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:10 INFO - 'NO_EM_RESTART': '1', 17:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:10 INFO - 'PWD': '/builds/slave/test', 17:11:10 INFO - 'SHELL': '/bin/bash', 17:11:10 INFO - 'SHLVL': '1', 17:11:10 INFO - 'TERM': 'linux', 17:11:10 INFO - 'TMOUT': '86400', 17:11:10 INFO - 'USER': 'cltbld', 17:11:10 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', 17:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:10 INFO - '_': '/tools/buildbot/bin/python'} 17:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:10 INFO - Downloading/unpacking jsonschema 17:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:11:12 INFO - Downloading/unpacking functools32 (from jsonschema) 17:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:12 INFO - Downloading functools32-3.2.3-2.tar.gz 17:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:11:12 INFO - warning: no files found matching '*.txt' 17:11:12 INFO - no previously-included directories found matching 'build' 17:11:12 INFO - no previously-included directories found matching 'dist' 17:11:12 INFO - no previously-included directories found matching '.git*' 17:11:12 INFO - Installing collected packages: jsonschema, functools32 17:11:12 INFO - Running setup.py install for functools32 17:11:12 INFO - warning: no files found matching '*.txt' 17:11:12 INFO - no previously-included directories found matching 'build' 17:11:12 INFO - no previously-included directories found matching 'dist' 17:11:12 INFO - no previously-included directories found matching '.git*' 17:11:12 INFO - Successfully installed jsonschema functools32 17:11:12 INFO - Cleaning up... 17:11:12 INFO - Return code: 0 17:11:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe97fb81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b580>, '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 0x1e2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c910>, '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': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', '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 17:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:11:12 INFO - Using env: {'DISPLAY': ':0', 17:11:12 INFO - 'HOME': '/home/cltbld', 17:11:12 INFO - 'LANG': 'en_US.UTF-8', 17:11:12 INFO - 'LANGUAGE': 'en_US:en', 17:11:12 INFO - 'LOGNAME': 'cltbld', 17:11:12 INFO - 'MAIL': '/var/mail/cltbld', 17:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:12 INFO - 'MOZ_NO_REMOTE': '1', 17:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:12 INFO - 'NO_EM_RESTART': '1', 17:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:12 INFO - 'PWD': '/builds/slave/test', 17:11:12 INFO - 'SHELL': '/bin/bash', 17:11:12 INFO - 'SHLVL': '1', 17:11:12 INFO - 'TERM': 'linux', 17:11:12 INFO - 'TMOUT': '86400', 17:11:12 INFO - 'USER': 'cltbld', 17:11:12 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', 17:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:12 INFO - '_': '/tools/buildbot/bin/python'} 17:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:13 INFO - Downloading/unpacking flake8 17:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:11:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:11:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:11:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:11:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:11:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:11:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:11:15 INFO - no previously-included directories found matching 'docs/_build' 17:11:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:11:15 INFO - Running setup.py install for pep8 17:11:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:11:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:11:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:11:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:11:15 INFO - no previously-included directories found matching 'docs/_build' 17:11:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:11:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:11:15 INFO - Cleaning up... 17:11:15 INFO - Return code: 0 17:11:15 INFO - Running post-action listener: _resource_record_post_action 17:11:15 INFO - Running post-action listener: _start_resource_monitoring 17:11:15 INFO - Starting resource monitoring. 17:11:15 INFO - ##### 17:11:15 INFO - ##### Running install step. 17:11:15 INFO - ##### 17:11:15 INFO - Running pre-action listener: _resource_record_pre_action 17:11:15 INFO - Running main action method: install 17:11:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:11:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:11:16 INFO - Reading from file tmpfile_stdout 17:11:16 INFO - Detecting whether we're running mozinstall >=1.0... 17:11:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:11:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:11:16 INFO - Reading from file tmpfile_stdout 17:11:16 INFO - Output received: 17:11:16 INFO - Usage: mozinstall [options] installer 17:11:16 INFO - Options: 17:11:16 INFO - -h, --help show this help message and exit 17:11:16 INFO - -d DEST, --destination=DEST 17:11:16 INFO - Directory to install application into. [default: 17:11:16 INFO - "/builds/slave/test"] 17:11:16 INFO - --app=APP Application being installed. [default: firefox] 17:11:16 INFO - mkdir: /builds/slave/test/build/application 17:11:16 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'] 17:11:16 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 17:11:31 INFO - Reading from file tmpfile_stdout 17:11:31 INFO - Output received: 17:11:31 INFO - /builds/slave/test/build/application/firefox/firefox 17:11:31 INFO - Running post-action listener: _resource_record_post_action 17:11:31 INFO - ##### 17:11:31 INFO - ##### Running run-tests step. 17:11:31 INFO - ##### 17:11:31 INFO - Running pre-action listener: _resource_record_pre_action 17:11:31 INFO - Running main action method: run_tests 17:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:11:32 INFO - Python 2.7.3 17:11:32 INFO - Return code: 0 17:11:32 INFO - grabbing minidump binary from tooltool 17:11: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')]} 17:11:32 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 0x1e2b580>, '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 0x1e2c480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:11:32 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 17:11:32 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 17:11:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:11:32 INFO - Return code: 0 17:11:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:11:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:11:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:11:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:11:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:11:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:11:33 INFO - Return code: 0 17:11:33 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/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 17:11:33 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/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 17:11:33 INFO - Using env: {'DISPLAY': ':0', 17:11:33 INFO - 'HOME': '/home/cltbld', 17:11:33 INFO - 'LANG': 'en_US.UTF-8', 17:11:33 INFO - 'LANGUAGE': 'en_US:en', 17:11:33 INFO - 'LOGNAME': 'cltbld', 17:11:33 INFO - 'MAIL': '/var/mail/cltbld', 17:11:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:11:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:33 INFO - 'MOZ_NO_REMOTE': '1', 17:11:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:11:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:33 INFO - 'NO_EM_RESTART': '1', 17:11:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:33 INFO - 'PWD': '/builds/slave/test', 17:11:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:11:33 INFO - 'SHELL': '/bin/bash', 17:11:33 INFO - 'SHLVL': '1', 17:11:33 INFO - 'TERM': 'linux', 17:11:33 INFO - 'TMOUT': '86400', 17:11:33 INFO - 'USER': 'cltbld', 17:11:33 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606', 17:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:33 INFO - '_': '/tools/buildbot/bin/python'} 17:11:33 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/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 17:11:33 INFO - mozversion application_buildid: 20160309162727 17:11:33 INFO - mozversion application_changeset: 5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e 17:11:33 INFO - mozversion application_display_name: Nightly 17:11:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:11:33 INFO - mozversion application_name: Firefox 17:11:33 INFO - mozversion application_remotingname: firefox 17:11:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:11:33 INFO - mozversion application_vendor: Mozilla 17:11:33 INFO - mozversion application_version: 48.0a1 17:11:33 INFO - mozversion platform_buildid: 20160309162727 17:11:33 INFO - mozversion platform_changeset: 5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e 17:11:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:11:33 INFO - mozversion platform_version: 48.0a1 17:11:33 INFO - using testdate: 1457572293 17:11:33 INFO - actual date: 1457572293 17:11:33 INFO - starting webserver on 'localhost:48767' 17:11:33 INFO - SUITE-START | Running 2 tests 17:11:33 INFO - TEST-START | dromaeo_css 17:11:33 INFO - operating with platform_type : linux_ 17:11:33 INFO - Initialising browser for dromaeo_css test... 17:11:33 INFO - TEST-INFO | started process 27470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgfqoUU/profile http://localhost:48767/getInfo.html) 17:11:37 INFO - PROCESS | 27470 | __metrics Screen width/height:1600/1200 17:11:37 INFO - PROCESS | 27470 | colorDepth:24 17:11:37 INFO - PROCESS | 27470 | Browser inner width/height: 1024/697 17:11:37 INFO - PROCESS | 27470 | __metrics 17:11:38 ERROR - PROCESS | 27470 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:11:39 INFO - TEST-INFO | 27470: exit 0 17:11:39 INFO - Browser initialized. 17:11:39 INFO - Running cycle 1/1 for dromaeo_css test... 17:11:39 INFO - TEST-INFO | started process 27563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgfqoUU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:51 INFO - PROCESS | 27563 | RSS: Main: 154693632 17:11:51 INFO - PROCESS | 27563 | 17:12:42 INFO - PROCESS | 27563 | 1457572362456 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] 17:14:54 INFO - PROCESS | 27563 | Cycle 1(1): loaded http://localhost:48767/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48767/tests/dromaeo/cssquery-ext.html) 17:14:55 INFO - PROCESS | 27563 | RSS: Main: 224374784 17:14:55 INFO - PROCESS | 27563 | 17:17:57 INFO - PROCESS | 27563 | Cycle 1(1): loaded http://localhost:48767/tests/dromaeo/cssquery-ext.html (next: http://localhost:48767/tests/dromaeo/cssquery-jquery.html) 17:17:58 INFO - PROCESS | 27563 | RSS: Main: 242683904 17:17:58 INFO - PROCESS | 27563 | 17:21:00 INFO - PROCESS | 27563 | Cycle 1(1): loaded http://localhost:48767/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48767/tests/dromaeo/cssquery-mootools.html) 17:21:00 INFO - PROCESS | 27563 | RSS: Main: 230772736 17:21:00 INFO - PROCESS | 27563 | 17:24:02 INFO - PROCESS | 27563 | Cycle 1(1): loaded http://localhost:48767/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48767/tests/dromaeo/cssquery-prototype.html) 17:24:03 INFO - PROCESS | 27563 | RSS: Main: 201764864 17:24:03 INFO - PROCESS | 27563 | 17:27:05 INFO - PROCESS | 27563 | Cycle 1(1): loaded http://localhost:48767/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48767/tests/dromaeo/cssquery-yui.html) 17:27:06 INFO - PROCESS | 27563 | RSS: Main: 201859072 17:27:06 INFO - PROCESS | 27563 | 17:30:09 INFO - PROCESS | 27563 | Cycle 1(1): loaded http://localhost:48767/tests/dromaeo/cssquery-yui.html (next: http://localhost:48767/tests/dromaeo/cssquery-dojo.html) 17:30:09 INFO - PROCESS | 27563 | RSS: Main: 252538880 17:30:09 INFO - PROCESS | 27563 | 17:30:09 INFO - PROCESS | 27563 | __start_tp_report 17:30:09 INFO - PROCESS | 27563 | _x_x_mozilla_page_load 17:30:09 INFO - PROCESS | 27563 | _x_x_mozilla_page_load_details 17:30:09 INFO - PROCESS | 27563 | |i|pagename|runs| 17:30:09 INFO - PROCESS | 27563 | |0;dojo.html;2573.38439492513;2644.9338766530846;2648.09964612032;2664.5337066013453;2686.368703354711;4451.310046942729;4503.549645035495;4553.977230113849;4555;4574.839880604175;4551.340055691922;4618.284165954283;4621.0757848430285;4641.930371044437;4642.837500687477;4215.915681686372;4235.512916014652;4246.957530424703;4249.383839343293;4332.566743325674;4281.293586558214;4327.6754243431715;4329.610335069843;4360.084382279725;4362.432883725111;4071.97964010181;4163.125743593849;4260.552641972579;4268;4350.216960947044;4191.7694526801015;4212.073343864345;4213.641840443566;4215.451991241119;4216.072464057902;4189.685773566995;4190.706650534464;4199.370094485821;4203.348480985422;4293.055527783914;4487.640988720895;4497.347884556753;4505.053938672882;4511.458624964992;4556.3621093047;4874;4877.414710234794;4878.756062196911;4889.8777530561665;4929.605631549467;4778.784954677013;4838.274258861164;4906.067847109038;4936.605071594264;4944.6785958912915;4575.885602859888;4576.359309696645;4583.793729282123;4603.815847366135;4623.930641040387;5011.198208286657;5025.899482010339;5032.547070763649;5033.924491132636;5070.670406423571;4699.060187962353;4766.285057241372;4778.259369797687;4842.854714358575;4860.684055536379;4811.061842940593;4827.517248275215;4828.130936431476;4875.43932447773;4877.292792545061;4784.210605250164;4787.952120478821;4789.976050119797;4795.95204047962;4830.830920917751;4678.461976872635;4760.428748550127;4783.976080119577;4788.209945359046;4791.185498465269;4009.8195581198916;4070.1249231414795;4071.4096456014304;4096.959030409717;4112.753234805921;3565.2512972276113;3573.5711714594413;3580.98209508956;3609.007522931215;3620.149264922741;4102.630763231324;4182.958170418317;4201.537830838605;4205.074883525619;4216.557261487561;4890.046440943982;4891.486393928586;4900.656954013256;4905.705657660552;4943.604511639061;4190.685698572619;4213.6839737019845;4215.451991241119;4253.319468885025;4255.021345090647;4259.595338442843;4318.050028993616;4347.239233134189;4363.2364336241035;4441.555844415597;4711.387519622427;4721.598664113589;4724.692894961817;4734.692245004064;4745.549172828576;4955.281484184845;4955.776990035385;4958.57852082577;4960.355153829979;4997.400311962588;4477.8208871644765;4655.487896331469;4710.411198600175;4744.952550474589;4748.715077095385;4799.592034677092;4820.6143508518535;4821.734804585782;4823.734694591831;4872.317875497362;4889.511048895082;4891.413030436371;4895.33912921751;4896.1921282987905;4937.876553086202;4613.423322084739;4736.763161841825;4782.545658162469;4797.184478638709;4833.95166048335;4716.1510928033285;4739.526047395233;4745.145873742759;4746.644001699955;4782.545658162469;4495.460544734653;4648.325992730967;4652.3719297895705;4665.883352916204;4701.271302948048;4588.472325682589;4674.485806561208;4741.170295198395;4742.66801323904;4834;4647.837325693585;4655.20861453547;4656.41794775653;4661.067786442793;4708.340832283415 17:30:09 INFO - PROCESS | 27563 | |1;ext.html;505.2572718104385;509.9898002039959;519.6362546217648;533.9800980127957;534.3934634190198;24478;32696.836515817417;33192.66807331926;33202.33595328092;33248.5012724809;36323.636763632356;36836.81581592095;36877;36903;36951.445728314095;7600.391968642509;7772.3393511551585;7773.455858089936;7783.766487005399;7785;7599.544027358376;7690.500117492373;7720.652570634307;7727.61361931904;7839.25527074927;7798.103218129902;7919.049714034295;7975.561344126071;7976.162502937195;7982.760517184493;7851.057873055212;7914.920850791505;7930;7932.920670793276;7938.841223175562;7874.842503149905;7972.60136993148;8004.519728816232;8004.879926801103;8012.3990700697095;36298.45552316718;36778.264434711426;36789.81605091984;36837.447438288444;36876.631233687585;3002.2944608017096;3014.804037737562;3018.411409775095;3048.6189226346705;3216.549683044352;28127.07670029064;28404.43191136166;28567.57148642772;28620;28704.425911481863;3489.45913383426;3495.94756078659;3504.5444092267844;3531.94702079469;3574.249407624402;220549.89725051433;220779;220824;221157;221252;52878.20682689763;53117.2032419514;53517.1972420414;53622.73188634032;53650.73174634102;55939.720301399044;60519;61276.693616532524;61329;61408.692956534935;12267.69330766738;12442.37788110591;12467.875321246853;12477.625671229878;12512;8645.221930026328;8658.307335413152;8669.739907802776;8680.56597170139;8684.478931264019;19565;19851.900740496207;19893;19947.900260498605;20034.398968030982;7441.404687624977;7678.57767822764;7694.807629809187;7769.650365733555;7833.2166783322355;736.9520981136209;738.1584993107862;740.5408646639119;853.5476197615274;904.6607522179182;25775;26615.467690646077;26640.46719065608;27034.5944810828;27035.1889443317;700.9369156775915;874.2787200559437;914.2000749344323;939.7227817793768;1078.417654466595;11668.474918628683;12089.214201077079;12147.603025652163;12253.69365765863;12336.074794390457;260167;262172;265158;265443;265548;41463.37804932929;41788.79105604452;41811.7909410451;41885.79057104695;41963.7901810489;1100.8293714474269;1120.4621781544904;1147.862256529205;1151.585429245471;1251.0992085698283;23204.76795232026;23743.287701368987;24366;24386.756132439157;24407.145749898667;32440.188995275308;32842.67157328492;32851.34297313992;32852.507212391356;32864.342713146085;141140;142666.28666857016;142782;142792;299873;27496.862515687295;27990.860045699643;28038.579421309103;28230;28385.148445546667;32498;41341.58658413497;42648.5735142657;42940.78529607332;46842.76578617221;32876.17809554685;38462.6153738459;39253.60746392499;39539.604603954744;40088.1982360357;32337.35325293528;33382;33529.49705754367;33722.494162588075;34002.829985849916;33130;33470.33059338751;33680.49479257862;33698.494522582674;33840.66159338375;28641.28396790097;30234.54648180235;30345.24136896507;30414.239644009078;30666.233344166576;23674.52650947006;23968.52062958696;24205.51588968246;24288.51422971566;24373.878130609235 17:30:09 INFO - PROCESS | 27563 | |2;jquery.html;324.80349388619896;342.1890120414617;343.94496880499116;352.7266368564364;353.00628730124697;15466.536003919873;15997.84002159978;16571.668566628676;16616.501504954842;16683.08243046632;14453.349599268058;14724.337404816783;15030.323635436403;15133.394664213418;15147.924260378682;4815.157347464197;4964.851054468371;4966.783138131163;4966.826161084363;4986.401631804189;4774.212254977924;4997.475265097167;5001.774920128603;5001.899962000758;5003.099442100421;4943.876403089934;4951.084049450845;4952.678075925071;4958.082754690376;4961.280614310923;4939.333190019355;4942.233953737176;5518.448155184489;5756.740946657411;5761.423857614205;5104.540591346797;5123.129068058439;5130.538251557377;5133.30700355451;5141.100307446182;11215.158863085302;11633.011194048431;11633.650990470214;11644.941775291154;18605.7209141863;1611.4521062838573;1633.1752465005216;1641.5896025993502;1661.7424299233637;2191.485001024758;8703.912960870373;9142.497162656051;9158.633654653873;11118.499667514981;12500.937495312466;1682.2345832646117;1776.6624341375227;1840.5490654789662;1861.3299212283566;1867.2904296367428;53810.192847107326;55072;55371.723141384435;55526.72236638831;56785.716071420204;10012.849807252896;10039.648612298535;10042.949785251172;10061.094501494754;10191;12802.16785908913;12880.09839311258;12940.417681204368;12940.805887911689;12970.286634235208;6576.342365763386;6620.437262832713;6632.668366581652;6747.05541224229;6748.628825414649;6094.8171554853425;6165.537584681167;6217.285012223652;6217.751289948352;6228.22147231596;4084.223997440477;4230.8519201827785;4284.2930916398445;4291.6566674665955;4369.388285640013;1537.4772577323763;1698.6347935193746;1715.613986852948;1718.5703574106474;1769.460314604058;772.2277722277722;850.1880703927734;899.7795540092719;965.4496936745987;977.3061126600052;14373.712525749426;15584.376624935103;15591.844081559038;15922.522324330057;16037.117958512394;749.606456610284;807.7092246791151;811.9066307374609;853.9829203415896;863.2403484933219;8490.872636910452;8747.431416957877;8943.23982461485;8961.283097352327;8999.415038022507;350525;356929;367679;368753;373380;56139.43860561424;60940;62810;63780;66614;917.2066162769156;935.1910597333258;955.8231727130642;957.8084383123403;958.7698952251549;11412.31526108436;13525;14554.12675239489;14576.34406451691;14736.631584210481;29143;29578.556321654763;29915.700842991293;30016.849915751154;30636.387272253985;36377.81811091033;45524.77237613791;47200.7639961798;47212.52787472219;47479.287810683556;7056.364927156581;7196.460265480215;7244.239354867874;7287.089113860768;7361.337479626859;7960.874338756409;11108.166887483309;11180.161487888603;11238.55045798159;11249.943750281196;5748.856278593069;9264.305177111879;9363.157315841334;9513.33406661527;10017.899821001989;9813.214942804701;10171.796564068529;10189.949050254998;10319.638812641522;10430.582776688847;9854.802903941738;10156.542955566869;10206.693799186036;10476.818676980618;10715;7283.7450689225625;7417.629118543943;7421.406287497095;7463.2909873564095;7540.698372065056;7128.501004929605;9566.569504372459;9696.272779541421;9810.901890980998;10003.14973227284 17:30:09 INFO - PROCESS | 27563 | |3;mootools.html;1229.035207362221;1367.6649220940872;1393.261571367175;1529.3270960777256;1769.5576105973498;7248.383887369573;7431.368333691643;7433.851322973537;7439.888401673979;7454.664540095695;7312.744053958112;7470.36501897338;7479.252074792518;7485.962570187142;7486;1846.473754979831;2149.6345621244427;2205.0628482894786;2214.7785221477843;2244.7306323241232;2215.025388828918;2227.387468446174;2229.9554008919813;2229.977700223001;2231.3082944287244;2087.4155236533793;2175.4670105824093;2178.7494438139656;2179.280837323687;2179.6512557990723;2142.0789060703814;2167.9783202168014;2176.249194028058;2181.4001149683963;2183.6287831068757;2133.423975526615;2137.3694760045823;2148.8495805293637;2152.494163871489;2154.6121698094335;7679.57762323072;7740.380769538423;7750.341220996222;7751.922480775176;7776.650050747673;4457.2199865023495;4562.475315338712;4567.0409214065085;4570.794314255866;4577.496475387705;2876.8561571921528;2908.2583941094886;2964;2970.3168271297723;3009.277773334406;913.2785099771173;923.422860712055;931.0549791961165;939.8496240601471;954.4321128928276;10576.365418074864;10607.416592087433;10622.57509699611;10630.415327157003;10644.308119972176;4215.59951804578;4300.80646370914;4358.193734159191;4389.714668546534;4392.297232442794;8962.238209752244;8962.551872406353;8978.191962723386;8986.14631609996;8986.86519702205;3797.145642230476;4496.505384407713;4511.255642818898;4516.412866327357;4516.909661806745;3920.2159568085926;3990.501187351581;3992.1416895367634;4014.2573623879675;4031.6169963853386;3537.398642230827;3612.909677258037;3633.182533929845;3634.7819130851703;3689.9077523062138;1124.0670243697712;1126.7352172239516;1131.1177281720272;1148.8621365436202;1151;891.4873947480224;899.9280057595377;901.3285102598606;906.9229115525122;1220.1337050693928;6911.516193866481;6967.163940327193;6997.685104170325;7005.439564834801;7012.193597736224;448.41929701037236;450.99098018039456;452.3373258176721;458.06783196195585;460.3164301012993;5316.564527577532;5328.36059672834;5349.812756553502;5388.91916621251;5394.083005889008;8890.86663700045;9382.85925711115;9398.67104651334;9455.243580513543;9512.619495220251;9290.814183716288;9335.813283734424;9387.389819661701;9409.388389754644;9444.102810233016;7096.61615984878;7165.426765858719;7180.3537681608905;7208.71165153388;7264.818379540448;6834.589924604539;6847.897281540881;6850.965745171242;6851.246362900177;6887.690053947685;8112.22933821286;8225.670973161246;8384.958075209584;8517.616707248064;8527.53098579584;8564.700235491728;8669.869951950599;8687.869681954902;8691.782705432415;8695.956520217358;5504.394516603091;6008.339082700812;6169.537284703575;6246.812595622138;6313.779017734358;6982.720691172296;7004.754833580801;7025.648717564203;7042;7050.541714788523;6236.126942228182;6407.16706828128;6427.807165785034;6435.356464353527;6441.066045423481;6241.625502469867;6250.406211409909;6256.186695729526;6354.650494222862;6453.709583068679;6613.206415230203;6631.900521492278;6680.63256520896;6686.866262674816;6697.732090716317;5980.222571065734;6102.359252278625;6126.785562505291;6133.478654314434;6297.622142671455;6329.588576742682;6341.619502829845;6397.328280530477;6408.519361047846;6410.8076757697345 17:30:09 INFO - PROCESS | 27563 | |4;prototype.html;309.24235622724325;311.3865684601336;312.60299419736947;312.95305704144374;312.9671384504627;5203.947960520393;5214.843554693361;5377.354717433904;5380.542653874416;5399.1091469907515;5224.1902505111675;5273.5781137509;5299.019681358951;5300.787968481256;5305.124654432024;3852.672522835562;3959.663428608572;4073.9388909166237;4079.1637714268504;4079.7144199906093;4061.4110953911663;4064.796760161995;4069.5930406959214;4069.857554985576;4075.225707115653;4016.7188296819236;4021.155557332964;4022.879313620596;4026.1142548639255;4030.0730831908677;3834.4440056191834;3934.7245692801516;4022.275990321741;4034.334334834749;4040.676745860324;3501.422265326218;3504.211552400715;3506.140995456104;3511.332846759133;3513.2797776455764;5021.39743230811;5038.924416133761;5041.092603331399;5045.520675535819;5056.292119103328;4565.1098035883015;4600.654950878664;4602.9079418411775;4607.10161518504;4616.169089563878;5494.917576236359;5496.4778346057465;5509.724513774296;5516.475934786229;5534.335879694422;3823;3825.48355971943;3830.2148059647707;3831;3833.7891415972113;5633.718314084321;5723.627964182357;5806.158107074492;5811.128330750379;5827.319433060755;3879.3017256893468;3888.902777430587;3916.980415097906;3918.6081391860585;3923.7449565778134;3964.83037503937;3974.3044967130636;3974.582668819732;3976.741511801724;3978.622030907059;4571.588557029883;4573.81704731807;4577.015941572511;4582.747948862844;4583.793729282191;5506.366767821672;5509.944900550943;5511.862203444865;5516.310461192351;5516.696581688046;1377.7175678985784;1406.1422532255317;1408.4155075643698;1408.4999825061955;1408.6267139208119;874.7681864305964;909.9681511147078;932.911373419524;960.1406740966795;961.33667769239;4753.33453316536;4832.734199619054;4832.8791780205775;4875.366202393666;4907.509249075064;5748.051571490657;5771.192033115283;5782.10377391505;5784.2769653793275;5786.450287222707;4877.780499877514;4881.877953051202;4882.389701287339;4882.536159064884;4884.7069175849565;3051.786374953732;3080.5687203791485;3083.768717346163;3086.845657717105;3094.071778466451;5439.918401223906;5451.2640793493165;5454.59090568209;5457.61796674229;5463.945360546423;5748.626339288016;5919.319278283053;5956.8808623828145;5963.403659634088;5973.253343332083;5456.536194423518;5479.75341109651;5521.089020311764;5522.0336441121835;5522.530584900248;5760.654360738202;5762.193292939076;5763.625364351304;5763.884722305615;5769;5648.237487939075;5654.547636189177;5657.12314591239;5660.745266463102;5661.858453538694;5464.808731694372;5474.753636086306;5475.2334673145;5476.17857321405;5479.342478902558;3897.9610203897596;3899.2786334528205;3996.56037835832;4000.739951903117;4002.3596224603925;5627.803026894039;5634.042212823748;5723.971380143073;5725.370209277059;5726.914096288642;5496.587755918242;5503.422140675171;5505.339359276913;5514.228008078952;5518.144687573433;5487.094629386106;5505.9724701376235;5506.174073888948;5518.696471693935;5522.6134170607675;5391.75737091824;5401.405845356929;5407.918881216863;5418.810341638024;5420.7560659769615;5391.272178256042;5528.364238112668;5548.639338442988;5552.444755524415;5555;5369.5167434931045;5398.109311963639;5407.702576358338;5416.295881535533;5427.185922111715 17:30:09 INFO - PROCESS | 27563 | |5;yui.html;723.363440172648;749.5989645539634;755.7581573896354;763.1910175214273;773.6982576795048;11743.53025878965;11813.704657383549;11818;11824.704382390444;11866.703332416682;11343.716407089827;11400;11423.371714555697;11428.485718142683;11433;793.3217099380033;810.1412502747107;811.3792948394483;811.9066307374638;812.4394168024045;790.5809920742016;804.4288555125868;805.1344804335333;806.6329819931917;806.7983004248938;842.7640260727006;846.7840700621333;847.5126802088793;847.5126802088793;848.6266042941118;836.5273620404452;838.76933843193;839.2614499240659;839.7144970709958;841.8148007438353;621.3072424246977;625.9593126446766;626.0577830365316;626.4549841637759;626.6553395632429;12528.81206781899;12551.435185416587;12553.372331383485;12592.370381480981;12619.747605047847;11452.770944581145;11638.243514171552;11901.761964760743;12191.817122743167;12204.877951220551;9422.057794220591;9583;9588.185004274645;9699.70900872975;9735.756606084833;3178.7933784304178;3269.4115059289556;3272.296456261915;3274.836258187081;3330.6669333066498;34424;35397.82301088478;39000.41499377511;39394.40908386348;39562.20875582501;9605.807883842284;9652.806943861084;9725.416475011521;9768.21854251658;9930.155936745457;15938.203089845461;15938.28277727505;15975.201239937956;15984.280707368196;15994.280257388446;6441.355864413521;6465.903011454832;6529.869402611921;6634.137562116894;6647.867042659216;3302.9339413212083;3385.509101180315;3395.5416018837636;3402.557667503209;3406.880759173417;2598.2854714953537;2650.443406884576;2655.2830735701255;2664.1607893513483;2667.906623268176;476.4282860567333;483.079733108429;487.7366222239951;489.40781654198815;494.4733858440749;488.1774210455323;533.3466503533141;540.5729473715799;549.3517649174013;593.9703014849326;7850.646720897574;7929.167437419103;7938.682452701943;7972.402069844785;8201.548914809742;487.49057235189315;540.7809837016015;617.7096764520668;618.7957973868613;629.7512482569451;3629.927401452009;3746.4942232798767;3797.6012518685693;3800.4299355096405;3801.7644265613785;50062.499375005784;50665.49334506682;50679.493205067476;50682;50694.74652626713;35410.645893540735;41179;41986.580134198266;41987.580124198976;42574;42376.152476950905;43254.783726081165;43487.130257394674;43490;43700.78149609231;8054.919450805417;8177.855884012356;8283.50298982063;8368.581570921551;8414.901096490174;31018.689813102483;31188.16583429572;31819.522707159875;31860.681393185772;32111.197220069684;34244.31511369808;34383.65616343805;34634.653653463145;36123.63876361203;41431.37852932148;10165.695029149138;10219.48902554884;10420.426876521864;10474.528646210787;10731;9725.951370243103;10000.499975001076;10062.044105809937;11521.82717259225;11639.243449175776;9681.515924203903;9695.466749328854;9705.12653861156;9791.216702663913;10048.497575121068;9420.62317507292;9559.904400955902;9569;9641.132298093205;9674.75813104678;9725.708228753148;9791.46146961924;9820.607175713178;9839.754006149617;10165;8187.181281871765;8215;8404.537750423786;8466.957665211634;8588.26999705032;8097.514149151069;8341.958290208753;8426.452280601741;8516.318694504302;8602.78493037679 17:30:09 INFO - PROCESS | 27563 | __end_tp_report 17:30:09 INFO - PROCESS | 27563 | __start_cc_report 17:30:09 INFO - PROCESS | 27563 | _x_x_mozilla_cycle_collect,1050 17:30:09 INFO - PROCESS | 27563 | __end_cc_report 17:30:09 INFO - PROCESS | 27563 | __startTimestamp1457573409397__endTimestamp 17:30:09 INFO - PROCESS | 27563 | 17:30:09 INFO - PROCESS | 27563 | ------- Summary: start ------- 17:30:09 INFO - PROCESS | 27563 | Number of tests: 6 17:30:09 INFO - PROCESS | 27563 | 17:30:09 INFO - PROCESS | 27563 | [#0] dojo.html Cycles:165 Average:4516.64 Median:4655.21 stddev:460.58 (9.9%) stddev-sans-first:436.03 17:30:09 INFO - PROCESS | 27563 | Values: 2573.4 2644.9 2648.1 2664.5 2686.4 4451.3 4503.5 4554.0 4555.0 4574.8 4551.3 4618.3 4621.1 4641.9 4642.8 4215.9 4235.5 4247.0 4249.4 4332.6 4281.3 4327.7 4329.6 4360.1 4362.4 4072.0 4163.1 4260.6 4268.0 4350.2 4191.8 4212.1 4213.6 4215.5 4216.1 4189.7 4190.7 4199.4 4203.3 4293.1 4487.6 4497.3 4505.1 4511.5 4556.4 4874.0 4877.4 4878.8 4889.9 4929.6 4778.8 4838.3 4906.1 4936.6 4944.7 4575.9 4576.4 4583.8 4603.8 4623.9 5011.2 5025.9 5032.5 5033.9 5070.7 4699.1 4766.3 4778.3 4842.9 4860.7 4811.1 4827.5 4828.1 4875.4 4877.3 4784.2 4788.0 4790.0 4796.0 4830.8 4678.5 4760.4 4784.0 4788.2 4791.2 4009.8 4070.1 4071.4 4097.0 4112.8 3565.3 3573.6 3581.0 3609.0 3620.1 4102.6 4183.0 4201.5 4205.1 4216.6 4890.0 4891.5 4900.7 4905.7 4943.6 4190.7 4213.7 4215.5 4253.3 4255.0 4259.6 4318.1 4347.2 4363.2 4441.6 4711.4 4721.6 4724.7 4734.7 4745.5 4955.3 4955.8 4958.6 4960.4 4997.4 4477.8 4655.5 4710.4 4745.0 4748.7 4799.6 4820.6 4821.7 4823.7 4872.3 4889.5 4891.4 4895.3 4896.2 4937.9 4613.4 4736.8 4782.5 4797.2 4834.0 4716.2 4739.5 4745.1 4746.6 4782.5 4495.5 4648.3 4652.4 4665.9 4701.3 4588.5 4674.5 4741.2 4742.7 4834.0 4647.8 4655.2 4656.4 4661.1 4708.3 17:30:09 INFO - PROCESS | 27563 | 17:30:09 INFO - PROCESS | 27563 | [#1] ext.html Cycles:180 Average:38024.08 Median:33781.58 stddev:58952.60 (174.5%) stddev-sans-first:59050.67 17:30:09 INFO - PROCESS | 27563 | Values: 505.3 510.0 519.6 534.0 534.4 24478.0 32696.8 33192.7 33202.3 33248.5 36323.6 36836.8 36877.0 36903.0 36951.4 7600.4 7772.3 7773.5 7783.8 7785.0 7599.5 7690.5 7720.7 7727.6 7839.3 7798.1 7919.0 7975.6 7976.2 7982.8 7851.1 7914.9 7930.0 7932.9 7938.8 7874.8 7972.6 8004.5 8004.9 8012.4 36298.5 36778.3 36789.8 36837.4 36876.6 3002.3 3014.8 3018.4 3048.6 3216.5 28127.1 28404.4 28567.6 28620.0 28704.4 3489.5 3495.9 3504.5 3531.9 3574.2 220549.9 220779.0 220824.0 221157.0 221252.0 52878.2 53117.2 53517.2 53622.7 53650.7 55939.7 60519.0 61276.7 61329.0 61408.7 12267.7 12442.4 12467.9 12477.6 12512.0 8645.2 8658.3 8669.7 8680.6 8684.5 19565.0 19851.9 19893.0 19947.9 20034.4 7441.4 7678.6 7694.8 7769.7 7833.2 737.0 738.2 740.5 853.5 904.7 25775.0 26615.5 26640.5 27034.6 27035.2 700.9 874.3 914.2 939.7 1078.4 11668.5 12089.2 12147.6 12253.7 12336.1 260167.0 262172.0 265158.0 265443.0 265548.0 41463.4 41788.8 41811.8 41885.8 41963.8 1100.8 1120.5 1147.9 1151.6 1251.1 23204.8 23743.3 24366.0 24386.8 24407.1 32440.2 32842.7 32851.3 32852.5 32864.3 141140.0 142666.3 142782.0 142792.0 299873.0 27496.9 27990.9 28038.6 28230.0 28385.1 32498.0 41341.6 42648.6 42940.8 46842.8 32876.2 38462.6 39253.6 39539.6 40088.2 32337.4 33382.0 33529.5 33722.5 34002.8 33130.0 33470.3 33680.5 33698.5 33840.7 28641.3 30234.5 30345.2 30414.2 30666.2 23674.5 23968.5 24205.5 24288.5 24373.9 17:30:09 INFO - PROCESS | 27563 | 17:30:09 INFO - PROCESS | 27563 | [#2] jquery.html Cycles:180 Average:21809.36 Median:26126.75 stddev:59622.77 (228.2%) stddev-sans-first:59768.21 17:30:09 INFO - PROCESS | 27563 | Values: 324.8 342.2 343.9 352.7 353.0 15466.5 15997.8 16571.7 16616.5 16683.1 14453.3 14724.3 15030.3 15133.4 15147.9 4815.2 4964.9 4966.8 4966.8 4986.4 4774.2 4997.5 5001.8 5001.9 5003.1 4943.9 4951.1 4952.7 4958.1 4961.3 4939.3 4942.2 5518.4 5756.7 5761.4 5104.5 5123.1 5130.5 5133.3 5141.1 11215.2 11633.0 11633.7 11644.9 18605.7 1611.5 1633.2 1641.6 1661.7 2191.5 8703.9 9142.5 9158.6 11118.5 12500.9 1682.2 1776.7 1840.5 1861.3 1867.3 53810.2 55072.0 55371.7 55526.7 56785.7 10012.8 10039.6 10042.9 10061.1 10191.0 12802.2 12880.1 12940.4 12940.8 12970.3 6576.3 6620.4 6632.7 6747.1 6748.6 6094.8 6165.5 6217.3 6217.8 6228.2 4084.2 4230.9 4284.3 4291.7 4369.4 1537.5 1698.6 1715.6 1718.6 1769.5 772.2 850.2 899.8 965.4 977.3 14373.7 15584.4 15591.8 15922.5 16037.1 749.6 807.7 811.9 854.0 863.2 8490.9 8747.4 8943.2 8961.3 8999.4 350525.0 356929.0 367679.0 368753.0 373380.0 56139.4 60940.0 62810.0 63780.0 66614.0 917.2 935.2 955.8 957.8 958.8 11412.3 13525.0 14554.1 14576.3 14736.6 29143.0 29578.6 29915.7 30016.8 30636.4 36377.8 45524.8 47200.8 47212.5 47479.3 7056.4 7196.5 7244.2 7287.1 7361.3 7960.9 11108.2 11180.2 11238.6 11249.9 5748.9 9264.3 9363.2 9513.3 10017.9 9813.2 10171.8 10189.9 10319.6 10430.6 9854.8 10156.5 10206.7 10476.8 10715.0 7283.7 7417.6 7421.4 7463.3 7540.7 7128.5 9566.6 9696.3 9810.9 10003.1 17:30:09 INFO - PROCESS | 27563 | 17:30:09 INFO - PROCESS | 27563 | [#3] mootools.html Cycles:180 Average:5244.15 Median:6248.61 stddev:2814.93 (45.0%) stddev-sans-first:2806.65 17:30:09 INFO - PROCESS | 27563 | Values: 1229.0 1367.7 1393.3 1529.3 1769.6 7248.4 7431.4 7433.9 7439.9 7454.7 7312.7 7470.4 7479.3 7486.0 7486.0 1846.5 2149.6 2205.1 2214.8 2244.7 2215.0 2227.4 2230.0 2230.0 2231.3 2087.4 2175.5 2178.7 2179.3 2179.7 2142.1 2168.0 2176.2 2181.4 2183.6 2133.4 2137.4 2148.8 2152.5 2154.6 7679.6 7740.4 7750.3 7751.9 7776.7 4457.2 4562.5 4567.0 4570.8 4577.5 2876.9 2908.3 2964.0 2970.3 3009.3 913.3 923.4 931.1 939.8 954.4 10576.4 10607.4 10622.6 10630.4 10644.3 4215.6 4300.8 4358.2 4389.7 4392.3 8962.2 8962.6 8978.2 8986.1 8986.9 3797.1 4496.5 4511.3 4516.4 4516.9 3920.2 3990.5 3992.1 4014.3 4031.6 3537.4 3612.9 3633.2 3634.8 3689.9 1124.1 1126.7 1131.1 1148.9 1151.0 891.5 899.9 901.3 906.9 1220.1 6911.5 6967.2 6997.7 7005.4 7012.2 448.4 451.0 452.3 458.1 460.3 5316.6 5328.4 5349.8 5388.9 5394.1 8890.9 9382.9 9398.7 9455.2 9512.6 9290.8 9335.8 9387.4 9409.4 9444.1 7096.6 7165.4 7180.4 7208.7 7264.8 6834.6 6847.9 6851.0 6851.2 6887.7 8112.2 8225.7 8385.0 8517.6 8527.5 8564.7 8669.9 8687.9 8691.8 8696.0 5504.4 6008.3 6169.5 6246.8 6313.8 6982.7 7004.8 7025.6 7042.0 7050.5 6236.1 6407.2 6427.8 6435.4 6441.1 6241.6 6250.4 6256.2 6354.7 6453.7 6613.2 6631.9 6680.6 6686.9 6697.7 5980.2 6102.4 6126.8 6133.5 6297.6 6329.6 6341.6 6397.3 6408.5 6410.8 17:30:09 INFO - PROCESS | 27563 | 17:30:09 INFO - PROCESS | 27563 | [#4] prototype.html Cycles:180 Average:4579.24 Median:5302.96 stddev:1358.16 (25.6%) stddev-sans-first:1323.62 17:30:09 INFO - PROCESS | 27563 | Values: 309.2 311.4 312.6 313.0 313.0 5203.9 5214.8 5377.4 5380.5 5399.1 5224.2 5273.6 5299.0 5300.8 5305.1 3852.7 3959.7 4073.9 4079.2 4079.7 4061.4 4064.8 4069.6 4069.9 4075.2 4016.7 4021.2 4022.9 4026.1 4030.1 3834.4 3934.7 4022.3 4034.3 4040.7 3501.4 3504.2 3506.1 3511.3 3513.3 5021.4 5038.9 5041.1 5045.5 5056.3 4565.1 4600.7 4602.9 4607.1 4616.2 5494.9 5496.5 5509.7 5516.5 5534.3 3823.0 3825.5 3830.2 3831.0 3833.8 5633.7 5723.6 5806.2 5811.1 5827.3 3879.3 3888.9 3917.0 3918.6 3923.7 3964.8 3974.3 3974.6 3976.7 3978.6 4571.6 4573.8 4577.0 4582.7 4583.8 5506.4 5509.9 5511.9 5516.3 5516.7 1377.7 1406.1 1408.4 1408.5 1408.6 874.8 910.0 932.9 960.1 961.3 4753.3 4832.7 4832.9 4875.4 4907.5 5748.1 5771.2 5782.1 5784.3 5786.5 4877.8 4881.9 4882.4 4882.5 4884.7 3051.8 3080.6 3083.8 3086.8 3094.1 5439.9 5451.3 5454.6 5457.6 5463.9 5748.6 5919.3 5956.9 5963.4 5973.3 5456.5 5479.8 5521.1 5522.0 5522.5 5760.7 5762.2 5763.6 5763.9 5769.0 5648.2 5654.5 5657.1 5660.7 5661.9 5464.8 5474.8 5475.2 5476.2 5479.3 3898.0 3899.3 3996.6 4000.7 4002.4 5627.8 5634.0 5724.0 5725.4 5726.9 5496.6 5503.4 5505.3 5514.2 5518.1 5487.1 5506.0 5506.2 5518.7 5522.6 5391.8 5401.4 5407.9 5418.8 5420.8 5391.3 5528.4 5548.6 5552.4 5555.0 5369.5 5398.1 5407.7 5416.3 5427.2 17:30:09 INFO - PROCESS | 27563 | 17:30:09 INFO - PROCESS | 27563 | [#5] yui.html Cycles:180 Average:11995.46 Median:50680.75 stddev:13489.43 (26.6%) stddev-sans-first:13500.71 17:30:09 INFO - PROCESS | 27563 | Values: 723.4 749.6 755.8 763.2 773.7 11743.5 11813.7 11818.0 11824.7 11866.7 11343.7 11400.0 11423.4 11428.5 11433.0 793.3 810.1 811.4 811.9 812.4 790.6 804.4 805.1 806.6 806.8 842.8 846.8 847.5 847.5 848.6 836.5 838.8 839.3 839.7 841.8 621.3 626.0 626.1 626.5 626.7 12528.8 12551.4 12553.4 12592.4 12619.7 11452.8 11638.2 11901.8 12191.8 12204.9 9422.1 9583.0 9588.2 9699.7 9735.8 3178.8 3269.4 3272.3 3274.8 3330.7 34424.0 35397.8 39000.4 39394.4 39562.2 9605.8 9652.8 9725.4 9768.2 9930.2 15938.2 15938.3 15975.2 15984.3 15994.3 6441.4 6465.9 6529.9 6634.1 6647.9 3302.9 3385.5 3395.5 3402.6 3406.9 2598.3 2650.4 2655.3 2664.2 2667.9 476.4 483.1 487.7 489.4 494.5 488.2 533.3 540.6 549.4 594.0 7850.6 7929.2 7938.7 7972.4 8201.5 487.5 540.8 617.7 618.8 629.8 3629.9 3746.5 3797.6 3800.4 3801.8 50062.5 50665.5 50679.5 50682.0 50694.7 35410.6 41179.0 41986.6 41987.6 42574.0 42376.2 43254.8 43487.1 43490.0 43700.8 8054.9 8177.9 8283.5 8368.6 8414.9 31018.7 31188.2 31819.5 31860.7 32111.2 34244.3 34383.7 34634.7 36123.6 41431.4 10165.7 10219.5 10420.4 10474.5 10731.0 9726.0 10000.5 10062.0 11521.8 11639.2 9681.5 9695.5 9705.1 9791.2 10048.5 9420.6 9559.9 9569.0 9641.1 9674.8 9725.7 9791.5 9820.6 9839.8 10165.0 8187.2 8215.0 8404.5 8467.0 8588.3 8097.5 8342.0 8426.5 8516.3 8602.8 17:30:09 INFO - PROCESS | 27563 | -------- Summary: end -------- 17:30:09 INFO - PROCESS | 27563 | 17:30:10 INFO - TEST-INFO | 27563: exit 0 17:30:10 INFO - TEST-OK | dromaeo_css | took 1116870ms 17:30:10 INFO - TEST-START | kraken 17:30:10 INFO - operating with platform_type : linux_ 17:30:10 INFO - Initialising browser for kraken test... 17:30:10 INFO - TEST-INFO | started process 27744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoyYzUi/profile http://localhost:48767/getInfo.html) 17:30:14 INFO - PROCESS | 27744 | __metrics Screen width/height:1600/1200 17:30:14 INFO - PROCESS | 27744 | colorDepth:24 17:30:14 INFO - PROCESS | 27744 | Browser inner width/height: 1024/697 17:30:14 INFO - PROCESS | 27744 | __metrics 17:30:15 ERROR - PROCESS | 27744 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:30:15 INFO - PROCESS | 27744 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 17:30:16 INFO - TEST-INFO | 27744: exit 0 17:30:16 INFO - Browser initialized. 17:30:16 INFO - Running cycle 1/1 for kraken test... 17:30:16 INFO - TEST-INFO | started process 27825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoyYzUi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:30:28 INFO - PROCESS | 27825 | RSS: Main: 154198016 17:30:28 INFO - PROCESS | 27825 | 17:30:30 INFO - PROCESS | 27825 | Cycle 1(1): loaded http://localhost:48767/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48767/tests/kraken/driver.html?testName=audio-beat-detection) 17:30:31 INFO - PROCESS | 27825 | RSS: Main: 195252224 17:30:31 INFO - PROCESS | 27825 | 17:30:34 INFO - PROCESS | 27825 | Cycle 1(1): loaded http://localhost:48767/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48767/tests/kraken/driver.html?testName=audio-dft) 17:30:34 INFO - PROCESS | 27825 | RSS: Main: 183238656 17:30:34 INFO - PROCESS | 27825 | 17:30:37 INFO - PROCESS | 27825 | Cycle 1(1): loaded http://localhost:48767/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48767/tests/kraken/driver.html?testName=audio-fft) 17:30:38 INFO - PROCESS | 27825 | RSS: Main: 171745280 17:30:38 INFO - PROCESS | 27825 | 17:30:40 INFO - PROCESS | 27825 | Cycle 1(1): loaded http://localhost:48767/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48767/tests/kraken/driver.html?testName=audio-oscillator) 17:30:41 INFO - PROCESS | 27825 | RSS: Main: 172052480 17:30:41 INFO - PROCESS | 27825 | 17:30:43 INFO - PROCESS | 27825 | Cycle 1(1): loaded http://localhost:48767/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48767/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:30:43 INFO - PROCESS | 27825 | RSS: Main: 173944832 17:30:43 INFO - PROCESS | 27825 | 17:30:47 INFO - PROCESS | 27825 | Cycle 1(1): loaded http://localhost:48767/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48767/tests/kraken/driver.html?testName=imaging-darkroom) 17:30:47 INFO - PROCESS | 27825 | RSS: Main: 175296512 17:30:47 INFO - PROCESS | 27825 | 17:30:51 INFO - PROCESS | 27825 | Cycle 1(1): loaded http://localhost:48767/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48767/tests/kraken/driver.html?testName=imaging-desaturate) 17:30:51 INFO - PROCESS | 27825 | RSS: Main: 174292992 17:30:51 INFO - PROCESS | 27825 | 17:30:54 INFO - PROCESS | 27825 | Cycle 1(1): loaded http://localhost:48767/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48767/tests/kraken/driver.html?testName=json-parse-financial) 17:30:55 INFO - PROCESS | 27825 | RSS: Main: 174903296 17:30:55 INFO - PROCESS | 27825 | 17:30:56 INFO - PROCESS | 27825 | Cycle 1(1): loaded http://localhost:48767/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48767/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:30:57 INFO - PROCESS | 27825 | RSS: Main: 185020416 17:30:57 INFO - PROCESS | 27825 | 17:30:59 INFO - PROCESS | 27825 | Cycle 1(1): loaded http://localhost:48767/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48767/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:31:00 INFO - PROCESS | 27825 | RSS: Main: 182108160 17:31:00 INFO - PROCESS | 27825 | 17:31:02 INFO - PROCESS | 27825 | Cycle 1(1): loaded http://localhost:48767/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48767/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:31:02 INFO - PROCESS | 27825 | RSS: Main: 188624896 17:31:02 INFO - PROCESS | 27825 | 17:31:05 INFO - PROCESS | 27825 | Cycle 1(1): loaded http://localhost:48767/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48767/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:31:05 INFO - PROCESS | 27825 | RSS: Main: 196853760 17:31:05 INFO - PROCESS | 27825 | 17:31:08 INFO - PROCESS | 27825 | Cycle 1(1): loaded http://localhost:48767/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48767/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:31:09 INFO - PROCESS | 27825 | RSS: Main: 196263936 17:31:09 INFO - PROCESS | 27825 | 17:31:10 INFO - PROCESS | 27825 | Cycle 1(1): loaded http://localhost:48767/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48767/tests/kraken/driver.html?testName=ai-astar) 17:31:11 INFO - PROCESS | 27825 | RSS: Main: 256843776 17:31:11 INFO - PROCESS | 27825 | 17:31:11 INFO - PROCESS | 27825 | __start_tp_report 17:31:11 INFO - PROCESS | 27825 | _x_x_mozilla_page_load 17:31:11 INFO - PROCESS | 27825 | _x_x_mozilla_page_load_details 17:31:11 INFO - PROCESS | 27825 | |i|pagename|runs| 17:31:11 INFO - PROCESS | 27825 | |0;ai-astar;110;114;107;113;112;113;102;114;111;112 17:31:11 INFO - PROCESS | 27825 | |1;audio-beat-detection;160;141;151;179;137;163;157;141;189;137 17:31:11 INFO - PROCESS | 27825 | |2;audio-dft;161;162;160;162;161;160;162;162;163;160 17:31:11 INFO - PROCESS | 27825 | |3;audio-fft;73;74;104;95;73;75;74;112;95;74 17:31:11 INFO - PROCESS | 27825 | |4;audio-oscillator;95;95;135;95;95;94;137;95;96;146 17:31:11 INFO - PROCESS | 27825 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;117;117;119 17:31:11 INFO - PROCESS | 27825 | |6;imaging-darkroom;145;146;146;146;146;147;146;146;146;147 17:31:11 INFO - PROCESS | 27825 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;97;96 17:31:11 INFO - PROCESS | 27825 | |8;json-parse-financial;68;70;68;68;68;68;67;78;65;65 17:31:11 INFO - PROCESS | 27825 | |9;json-stringify-tinderbox;71;70;69;70;70;71;71;70;70;71 17:31:11 INFO - PROCESS | 27825 | |10;stanford-crypto-aes;81;84;82;82;82;81;81;82;82;82 17:31:11 INFO - PROCESS | 27825 | |11;stanford-crypto-ccm;125;124;129;122;130;122;120;122;121;119 17:31:11 INFO - PROCESS | 27825 | |12;stanford-crypto-pbkdf2;142;147;148;153;153;135;148;147;151;149 17:31:11 INFO - PROCESS | 27825 | |13;stanford-crypto-sha256-iterative;72;71;74;72;71;72;70;72;70;70 17:31:11 INFO - PROCESS | 27825 | __end_tp_report 17:31:11 INFO - PROCESS | 27825 | __start_cc_report 17:31:11 INFO - PROCESS | 27825 | _x_x_mozilla_cycle_collect,1142 17:31:11 INFO - PROCESS | 27825 | __end_cc_report 17:31:11 INFO - PROCESS | 27825 | __startTimestamp1457573471122__endTimestamp 17:31:11 INFO - PROCESS | 27825 | 17:31:11 INFO - PROCESS | 27825 | ------- Summary: start ------- 17:31:11 INFO - PROCESS | 27825 | Number of tests: 14 17:31:11 INFO - PROCESS | 27825 | 17:31:11 INFO - PROCESS | 27825 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.50 stddev:3.74 (3.3%) stddev-sans-first:3.95 17:31:11 INFO - PROCESS | 27825 | Values: 110.0 114.0 107.0 113.0 112.0 113.0 102.0 114.0 111.0 112.0 17:31:11 INFO - PROCESS | 27825 | 17:31:11 INFO - PROCESS | 27825 | [#1] audio-beat-detection Cycles:10 Average:155.50 Median:158.50 stddev:17.88 (11.3%) stddev-sans-first:18.89 17:31:11 INFO - PROCESS | 27825 | Values: 160.0 141.0 151.0 179.0 137.0 163.0 157.0 141.0 189.0 137.0 17:31:11 INFO - PROCESS | 27825 | 17:31:11 INFO - PROCESS | 27825 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 17:31:11 INFO - PROCESS | 27825 | Values: 161.0 162.0 160.0 162.0 161.0 160.0 162.0 162.0 163.0 160.0 17:31:11 INFO - PROCESS | 27825 | 17:31:11 INFO - PROCESS | 27825 | [#3] audio-fft Cycles:10 Average:84.90 Median:74.00 stddev:15.06 (20.3%) stddev-sans-first:15.34 17:31:11 INFO - PROCESS | 27825 | Values: 73.0 74.0 104.0 95.0 73.0 75.0 74.0 112.0 95.0 74.0 17:31:11 INFO - PROCESS | 27825 | 17:31:11 INFO - PROCESS | 27825 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:95.00 stddev:21.60 (22.7%) stddev-sans-first:22.37 17:31:11 INFO - PROCESS | 27825 | Values: 95.0 95.0 135.0 95.0 95.0 94.0 137.0 95.0 96.0 146.0 17:31:11 INFO - PROCESS | 27825 | 17:31:11 INFO - PROCESS | 27825 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 17:31:11 INFO - PROCESS | 27825 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 119.0 17:31:11 INFO - PROCESS | 27825 | 17:31:11 INFO - PROCESS | 27825 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 17:31:11 INFO - PROCESS | 27825 | Values: 145.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 17:31:11 INFO - PROCESS | 27825 | 17:31:11 INFO - PROCESS | 27825 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 17:31:11 INFO - PROCESS | 27825 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 97.0 96.0 17:31:11 INFO - PROCESS | 27825 | 17:31:11 INFO - PROCESS | 27825 | [#8] json-parse-financial Cycles:10 Average:68.50 Median:68.00 stddev:3.66 (5.4%) stddev-sans-first:3.88 17:31:11 INFO - PROCESS | 27825 | Values: 68.0 70.0 68.0 68.0 68.0 68.0 67.0 78.0 65.0 65.0 17:31:11 INFO - PROCESS | 27825 | 17:31:11 INFO - PROCESS | 27825 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 17:31:11 INFO - PROCESS | 27825 | Values: 71.0 70.0 69.0 70.0 70.0 71.0 71.0 70.0 70.0 71.0 17:31:11 INFO - PROCESS | 27825 | 17:31:11 INFO - PROCESS | 27825 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:0.88 (1.1%) stddev-sans-first:0.87 17:31:11 INFO - PROCESS | 27825 | Values: 81.0 84.0 82.0 82.0 82.0 81.0 81.0 82.0 82.0 82.0 17:31:11 INFO - PROCESS | 27825 | 17:31:11 INFO - PROCESS | 27825 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:123.00 stddev:3.66 (3.0%) stddev-sans-first:3.83 17:31:11 INFO - PROCESS | 27825 | Values: 125.0 124.0 129.0 122.0 130.0 122.0 120.0 122.0 121.0 119.0 17:31:11 INFO - PROCESS | 27825 | 17:31:11 INFO - PROCESS | 27825 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.30 Median:148.50 stddev:5.40 (3.6%) stddev-sans-first:5.37 17:31:11 INFO - PROCESS | 27825 | Values: 142.0 147.0 148.0 153.0 153.0 135.0 148.0 147.0 151.0 149.0 17:31:11 INFO - PROCESS | 27825 | 17:31:11 INFO - PROCESS | 27825 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:72.00 stddev:1.26 (1.8%) stddev-sans-first:1.32 17:31:11 INFO - PROCESS | 27825 | Values: 72.0 71.0 74.0 72.0 71.0 72.0 70.0 72.0 70.0 70.0 17:31:11 INFO - PROCESS | 27825 | -------- Summary: end -------- 17:31:11 INFO - PROCESS | 27825 | 17:31:12 INFO - TEST-INFO | 27825: exit 0 17:31:12 INFO - TEST-OK | kraken | took 61976ms 17:31:12 INFO - SUITE-END | took 1178s 17:31:12 INFO - Completed test suite (00:19:39) 17:31:12 INFO - javascript benchmark 17:31:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2573.38439492513, 2644.9338766530846, 2648.09964612032, 2664.5337066013453, 2686.368703354711, 4451.310046942729, 4503.549645035495, 4553.977230113849, 4555.0, 4574.839880604175, 4551.340055691922, 4618.284165954283, 4621.0757848430285, 4641.930371044437, 4642.837500687477, 4215.915681686372, 4235.512916014652, 4246.957530424703, 4249.383839343293, 4332.566743325674, 4281.293586558214, 4327.6754243431715, 4329.610335069843, 4360.084382279725, 4362.432883725111, 4071.97964010181, 4163.125743593849, 4260.552641972579, 4268.0, 4350.216960947044, 4191.7694526801015, 4212.073343864345, 4213.641840443566, 4215.451991241119, 4216.072464057902, 4189.685773566995, 4190.706650534464, 4199.370094485821, 4203.348480985422, 4293.055527783914, 4487.640988720895, 4497.347884556753, 4505.053938672882, 4511.458624964992, 4556.3621093047, 4874.0, 4877.414710234794, 4878.756062196911, 4889.8777530561665, 4929.605631549467, 4778.784954677013, 4838.274258861164, 4906.067847109038, 4936.605071594264, 4944.6785958912915, 4575.885602859888, 4576.359309696645, 4583.793729282123, 4603.815847366135, 4623.930641040387, 5011.198208286657, 5025.899482010339, 5032.547070763649, 5033.924491132636, 5070.670406423571, 4699.060187962353, 4766.285057241372, 4778.259369797687, 4842.854714358575, 4860.684055536379, 4811.061842940593, 4827.517248275215, 4828.130936431476, 4875.43932447773, 4877.292792545061, 4784.210605250164, 4787.952120478821, 4789.976050119797, 4795.95204047962, 4830.830920917751, 4678.461976872635, 4760.428748550127, 4783.976080119577, 4788.209945359046, 4791.185498465269, 4009.8195581198916, 4070.1249231414795, 4071.4096456014304, 4096.959030409717, 4112.753234805921, 3565.2512972276113, 3573.5711714594413, 3580.98209508956, 3609.007522931215, 3620.149264922741, 4102.630763231324, 4182.958170418317, 4201.537830838605, 4205.074883525619, 4216.557261487561, 4890.046440943982, 4891.486393928586, 4900.656954013256, 4905.705657660552, 4943.604511639061, 4190.685698572619, 4213.6839737019845, 4215.451991241119, 4253.319468885025, 4255.021345090647, 4259.595338442843, 4318.050028993616, 4347.239233134189, 4363.2364336241035, 4441.555844415597, 4711.387519622427, 4721.598664113589, 4724.692894961817, 4734.692245004064, 4745.549172828576, 4955.281484184845, 4955.776990035385, 4958.57852082577, 4960.355153829979, 4997.400311962588, 4477.8208871644765, 4655.487896331469, 4710.411198600175, 4744.952550474589, 4748.715077095385, 4799.592034677092, 4820.6143508518535, 4821.734804585782, 4823.734694591831, 4872.317875497362, 4889.511048895082, 4891.413030436371, 4895.33912921751, 4896.1921282987905, 4937.876553086202, 4613.423322084739, 4736.763161841825, 4782.545658162469, 4797.184478638709, 4833.95166048335, 4716.1510928033285, 4739.526047395233, 4745.145873742759, 4746.644001699955, 4782.545658162469, 4495.460544734653, 4648.325992730967, 4652.3719297895705, 4665.883352916204, 4701.271302948048, 4588.472325682589, 4674.485806561208, 4741.170295198395, 4742.66801323904, 4834.0, 4647.837325693585, 4655.20861453547, 4656.41794775653, 4661.067786442793, 4708.340832283415], "unit": "score", "name": "dojo.html", "value": 4488.522957556785}, {"lowerIsBetter": false, "replicates": [505.2572718104385, 509.9898002039959, 519.6362546217648, 533.9800980127957, 534.3934634190198, 24478.0, 32696.836515817417, 33192.66807331926, 33202.33595328092, 33248.5012724809, 36323.636763632356, 36836.81581592095, 36877.0, 36903.0, 36951.445728314095, 7600.391968642509, 7772.3393511551585, 7773.455858089936, 7783.766487005399, 7785.0, 7599.544027358376, 7690.500117492373, 7720.652570634307, 7727.61361931904, 7839.25527074927, 7798.103218129902, 7919.049714034295, 7975.561344126071, 7976.162502937195, 7982.760517184493, 7851.057873055212, 7914.920850791505, 7930.0, 7932.920670793276, 7938.841223175562, 7874.842503149905, 7972.60136993148, 8004.519728816232, 8004.879926801103, 8012.3990700697095, 36298.45552316718, 36778.264434711426, 36789.81605091984, 36837.447438288444, 36876.631233687585, 3002.2944608017096, 3014.804037737562, 3018.411409775095, 3048.6189226346705, 3216.549683044352, 28127.07670029064, 28404.43191136166, 28567.57148642772, 28620.0, 28704.425911481863, 3489.45913383426, 3495.94756078659, 3504.5444092267844, 3531.94702079469, 3574.249407624402, 220549.89725051433, 220779.0, 220824.0, 221157.0, 221252.0, 52878.20682689763, 53117.2032419514, 53517.1972420414, 53622.73188634032, 53650.73174634102, 55939.720301399044, 60519.0, 61276.693616532524, 61329.0, 61408.692956534935, 12267.69330766738, 12442.37788110591, 12467.875321246853, 12477.625671229878, 12512.0, 8645.221930026328, 8658.307335413152, 8669.739907802776, 8680.56597170139, 8684.478931264019, 19565.0, 19851.900740496207, 19893.0, 19947.900260498605, 20034.398968030982, 7441.404687624977, 7678.57767822764, 7694.807629809187, 7769.650365733555, 7833.2166783322355, 736.9520981136209, 738.1584993107862, 740.5408646639119, 853.5476197615274, 904.6607522179182, 25775.0, 26615.467690646077, 26640.46719065608, 27034.5944810828, 27035.1889443317, 700.9369156775915, 874.2787200559437, 914.2000749344323, 939.7227817793768, 1078.417654466595, 11668.474918628683, 12089.214201077079, 12147.603025652163, 12253.69365765863, 12336.074794390457, 260167.0, 262172.0, 265158.0, 265443.0, 265548.0, 41463.37804932929, 41788.79105604452, 41811.7909410451, 41885.79057104695, 41963.7901810489, 1100.8293714474269, 1120.4621781544904, 1147.862256529205, 1151.585429245471, 1251.0992085698283, 23204.76795232026, 23743.287701368987, 24366.0, 24386.756132439157, 24407.145749898667, 32440.188995275308, 32842.67157328492, 32851.34297313992, 32852.507212391356, 32864.342713146085, 141140.0, 142666.28666857016, 142782.0, 142792.0, 299873.0, 27496.862515687295, 27990.860045699643, 28038.579421309103, 28230.0, 28385.148445546667, 32498.0, 41341.58658413497, 42648.5735142657, 42940.78529607332, 46842.76578617221, 32876.17809554685, 38462.6153738459, 39253.60746392499, 39539.604603954744, 40088.1982360357, 32337.35325293528, 33382.0, 33529.49705754367, 33722.494162588075, 34002.829985849916, 33130.0, 33470.33059338751, 33680.49479257862, 33698.494522582674, 33840.66159338375, 28641.28396790097, 30234.54648180235, 30345.24136896507, 30414.239644009078, 30666.233344166576, 23674.52650947006, 23968.52062958696, 24205.51588968246, 24288.51422971566, 24373.878130609235], "unit": "score", "name": "ext.html", "value": 16188.204228190876}, {"lowerIsBetter": false, "replicates": [324.80349388619896, 342.1890120414617, 343.94496880499116, 352.7266368564364, 353.00628730124697, 15466.536003919873, 15997.84002159978, 16571.668566628676, 16616.501504954842, 16683.08243046632, 14453.349599268058, 14724.337404816783, 15030.323635436403, 15133.394664213418, 15147.924260378682, 4815.157347464197, 4964.851054468371, 4966.783138131163, 4966.826161084363, 4986.401631804189, 4774.212254977924, 4997.475265097167, 5001.774920128603, 5001.899962000758, 5003.099442100421, 4943.876403089934, 4951.084049450845, 4952.678075925071, 4958.082754690376, 4961.280614310923, 4939.333190019355, 4942.233953737176, 5518.448155184489, 5756.740946657411, 5761.423857614205, 5104.540591346797, 5123.129068058439, 5130.538251557377, 5133.30700355451, 5141.100307446182, 11215.158863085302, 11633.011194048431, 11633.650990470214, 11644.941775291154, 18605.7209141863, 1611.4521062838573, 1633.1752465005216, 1641.5896025993502, 1661.7424299233637, 2191.485001024758, 8703.912960870373, 9142.497162656051, 9158.633654653873, 11118.499667514981, 12500.937495312466, 1682.2345832646117, 1776.6624341375227, 1840.5490654789662, 1861.3299212283566, 1867.2904296367428, 53810.192847107326, 55072.0, 55371.723141384435, 55526.72236638831, 56785.716071420204, 10012.849807252896, 10039.648612298535, 10042.949785251172, 10061.094501494754, 10191.0, 12802.16785908913, 12880.09839311258, 12940.417681204368, 12940.805887911689, 12970.286634235208, 6576.342365763386, 6620.437262832713, 6632.668366581652, 6747.05541224229, 6748.628825414649, 6094.8171554853425, 6165.537584681167, 6217.285012223652, 6217.751289948352, 6228.22147231596, 4084.223997440477, 4230.8519201827785, 4284.2930916398445, 4291.6566674665955, 4369.388285640013, 1537.4772577323763, 1698.6347935193746, 1715.613986852948, 1718.5703574106474, 1769.460314604058, 772.2277722277722, 850.1880703927734, 899.7795540092719, 965.4496936745987, 977.3061126600052, 14373.712525749426, 15584.376624935103, 15591.844081559038, 15922.522324330057, 16037.117958512394, 749.606456610284, 807.7092246791151, 811.9066307374609, 853.9829203415896, 863.2403484933219, 8490.872636910452, 8747.431416957877, 8943.23982461485, 8961.283097352327, 8999.415038022507, 350525.0, 356929.0, 367679.0, 368753.0, 373380.0, 56139.43860561424, 60940.0, 62810.0, 63780.0, 66614.0, 917.2066162769156, 935.1910597333258, 955.8231727130642, 957.8084383123403, 958.7698952251549, 11412.31526108436, 13525.0, 14554.12675239489, 14576.34406451691, 14736.631584210481, 29143.0, 29578.556321654763, 29915.700842991293, 30016.849915751154, 30636.387272253985, 36377.81811091033, 45524.77237613791, 47200.7639961798, 47212.52787472219, 47479.287810683556, 7056.364927156581, 7196.460265480215, 7244.239354867874, 7287.089113860768, 7361.337479626859, 7960.874338756409, 11108.166887483309, 11180.161487888603, 11238.55045798159, 11249.943750281196, 5748.856278593069, 9264.305177111879, 9363.157315841334, 9513.33406661527, 10017.899821001989, 9813.214942804701, 10171.796564068529, 10189.949050254998, 10319.638812641522, 10430.582776688847, 9854.802903941738, 10156.542955566869, 10206.693799186036, 10476.818676980618, 10715.0, 7283.7450689225625, 7417.629118543943, 7421.406287497095, 7463.2909873564095, 7540.698372065056, 7128.501004929605, 9566.569504372459, 9696.272779541421, 9810.901890980998, 10003.14973227284], "unit": "score", "name": "jquery.html", "value": 7579.4750729171565}, {"lowerIsBetter": false, "replicates": [1229.035207362221, 1367.6649220940872, 1393.261571367175, 1529.3270960777256, 1769.5576105973498, 7248.383887369573, 7431.368333691643, 7433.851322973537, 7439.888401673979, 7454.664540095695, 7312.744053958112, 7470.36501897338, 7479.252074792518, 7485.962570187142, 7486.0, 1846.473754979831, 2149.6345621244427, 2205.0628482894786, 2214.7785221477843, 2244.7306323241232, 2215.025388828918, 2227.387468446174, 2229.9554008919813, 2229.977700223001, 2231.3082944287244, 2087.4155236533793, 2175.4670105824093, 2178.7494438139656, 2179.280837323687, 2179.6512557990723, 2142.0789060703814, 2167.9783202168014, 2176.249194028058, 2181.4001149683963, 2183.6287831068757, 2133.423975526615, 2137.3694760045823, 2148.8495805293637, 2152.494163871489, 2154.6121698094335, 7679.57762323072, 7740.380769538423, 7750.341220996222, 7751.922480775176, 7776.650050747673, 4457.2199865023495, 4562.475315338712, 4567.0409214065085, 4570.794314255866, 4577.496475387705, 2876.8561571921528, 2908.2583941094886, 2964.0, 2970.3168271297723, 3009.277773334406, 913.2785099771173, 923.422860712055, 931.0549791961165, 939.8496240601471, 954.4321128928276, 10576.365418074864, 10607.416592087433, 10622.57509699611, 10630.415327157003, 10644.308119972176, 4215.59951804578, 4300.80646370914, 4358.193734159191, 4389.714668546534, 4392.297232442794, 8962.238209752244, 8962.551872406353, 8978.191962723386, 8986.14631609996, 8986.86519702205, 3797.145642230476, 4496.505384407713, 4511.255642818898, 4516.412866327357, 4516.909661806745, 3920.2159568085926, 3990.501187351581, 3992.1416895367634, 4014.2573623879675, 4031.6169963853386, 3537.398642230827, 3612.909677258037, 3633.182533929845, 3634.7819130851703, 3689.9077523062138, 1124.0670243697712, 1126.7352172239516, 1131.1177281720272, 1148.8621365436202, 1151.0, 891.4873947480224, 899.9280057595377, 901.3285102598606, 906.9229115525122, 1220.1337050693928, 6911.516193866481, 6967.163940327193, 6997.685104170325, 7005.439564834801, 7012.193597736224, 448.41929701037236, 450.99098018039456, 452.3373258176721, 458.06783196195585, 460.3164301012993, 5316.564527577532, 5328.36059672834, 5349.812756553502, 5388.91916621251, 5394.083005889008, 8890.86663700045, 9382.85925711115, 9398.67104651334, 9455.243580513543, 9512.619495220251, 9290.814183716288, 9335.813283734424, 9387.389819661701, 9409.388389754644, 9444.102810233016, 7096.61615984878, 7165.426765858719, 7180.3537681608905, 7208.71165153388, 7264.818379540448, 6834.589924604539, 6847.897281540881, 6850.965745171242, 6851.246362900177, 6887.690053947685, 8112.22933821286, 8225.670973161246, 8384.958075209584, 8517.616707248064, 8527.53098579584, 8564.700235491728, 8669.869951950599, 8687.869681954902, 8691.782705432415, 8695.956520217358, 5504.394516603091, 6008.339082700812, 6169.537284703575, 6246.812595622138, 6313.779017734358, 6982.720691172296, 7004.754833580801, 7025.648717564203, 7042.0, 7050.541714788523, 6236.126942228182, 6407.16706828128, 6427.807165785034, 6435.356464353527, 6441.066045423481, 6241.625502469867, 6250.406211409909, 6256.186695729526, 6354.650494222862, 6453.709583068679, 6613.206415230203, 6631.900521492278, 6680.63256520896, 6686.866262674816, 6697.732090716317, 5980.222571065734, 6102.359252278625, 6126.785562505291, 6133.478654314434, 6297.622142671455, 6329.588576742682, 6341.619502829845, 6397.328280530477, 6408.519361047846, 6410.8076757697345], "unit": "score", "name": "mootools.html", "value": 4189.702054427685}, {"lowerIsBetter": false, "replicates": [309.24235622724325, 311.3865684601336, 312.60299419736947, 312.95305704144374, 312.9671384504627, 5203.947960520393, 5214.843554693361, 5377.354717433904, 5380.542653874416, 5399.1091469907515, 5224.1902505111675, 5273.5781137509, 5299.019681358951, 5300.787968481256, 5305.124654432024, 3852.672522835562, 3959.663428608572, 4073.9388909166237, 4079.1637714268504, 4079.7144199906093, 4061.4110953911663, 4064.796760161995, 4069.5930406959214, 4069.857554985576, 4075.225707115653, 4016.7188296819236, 4021.155557332964, 4022.879313620596, 4026.1142548639255, 4030.0730831908677, 3834.4440056191834, 3934.7245692801516, 4022.275990321741, 4034.334334834749, 4040.676745860324, 3501.422265326218, 3504.211552400715, 3506.140995456104, 3511.332846759133, 3513.2797776455764, 5021.39743230811, 5038.924416133761, 5041.092603331399, 5045.520675535819, 5056.292119103328, 4565.1098035883015, 4600.654950878664, 4602.9079418411775, 4607.10161518504, 4616.169089563878, 5494.917576236359, 5496.4778346057465, 5509.724513774296, 5516.475934786229, 5534.335879694422, 3823.0, 3825.48355971943, 3830.2148059647707, 3831.0, 3833.7891415972113, 5633.718314084321, 5723.627964182357, 5806.158107074492, 5811.128330750379, 5827.319433060755, 3879.3017256893468, 3888.902777430587, 3916.980415097906, 3918.6081391860585, 3923.7449565778134, 3964.83037503937, 3974.3044967130636, 3974.582668819732, 3976.741511801724, 3978.622030907059, 4571.588557029883, 4573.81704731807, 4577.015941572511, 4582.747948862844, 4583.793729282191, 5506.366767821672, 5509.944900550943, 5511.862203444865, 5516.310461192351, 5516.696581688046, 1377.7175678985784, 1406.1422532255317, 1408.4155075643698, 1408.4999825061955, 1408.6267139208119, 874.7681864305964, 909.9681511147078, 932.911373419524, 960.1406740966795, 961.33667769239, 4753.33453316536, 4832.734199619054, 4832.8791780205775, 4875.366202393666, 4907.509249075064, 5748.051571490657, 5771.192033115283, 5782.10377391505, 5784.2769653793275, 5786.450287222707, 4877.780499877514, 4881.877953051202, 4882.389701287339, 4882.536159064884, 4884.7069175849565, 3051.786374953732, 3080.5687203791485, 3083.768717346163, 3086.845657717105, 3094.071778466451, 5439.918401223906, 5451.2640793493165, 5454.59090568209, 5457.61796674229, 5463.945360546423, 5748.626339288016, 5919.319278283053, 5956.8808623828145, 5963.403659634088, 5973.253343332083, 5456.536194423518, 5479.75341109651, 5521.089020311764, 5522.0336441121835, 5522.530584900248, 5760.654360738202, 5762.193292939076, 5763.625364351304, 5763.884722305615, 5769.0, 5648.237487939075, 5654.547636189177, 5657.12314591239, 5660.745266463102, 5661.858453538694, 5464.808731694372, 5474.753636086306, 5475.2334673145, 5476.17857321405, 5479.342478902558, 3897.9610203897596, 3899.2786334528205, 3996.56037835832, 4000.739951903117, 4002.3596224603925, 5627.803026894039, 5634.042212823748, 5723.971380143073, 5725.370209277059, 5726.914096288642, 5496.587755918242, 5503.422140675171, 5505.339359276913, 5514.228008078952, 5518.144687573433, 5487.094629386106, 5505.9724701376235, 5506.174073888948, 5518.696471693935, 5522.6134170607675, 5391.75737091824, 5401.405845356929, 5407.918881216863, 5418.810341638024, 5420.7560659769615, 5391.272178256042, 5528.364238112668, 5548.639338442988, 5552.444755524415, 5555.0, 5369.5167434931045, 5398.109311963639, 5407.702576358338, 5416.295881535533, 5427.185922111715], "unit": "score", "name": "prototype.html", "value": 4144.007393198327}, {"lowerIsBetter": false, "replicates": [723.363440172648, 749.5989645539634, 755.7581573896354, 763.1910175214273, 773.6982576795048, 11743.53025878965, 11813.704657383549, 11818.0, 11824.704382390444, 11866.703332416682, 11343.716407089827, 11400.0, 11423.371714555697, 11428.485718142683, 11433.0, 793.3217099380033, 810.1412502747107, 811.3792948394483, 811.9066307374638, 812.4394168024045, 790.5809920742016, 804.4288555125868, 805.1344804335333, 806.6329819931917, 806.7983004248938, 842.7640260727006, 846.7840700621333, 847.5126802088793, 847.5126802088793, 848.6266042941118, 836.5273620404452, 838.76933843193, 839.2614499240659, 839.7144970709958, 841.8148007438353, 621.3072424246977, 625.9593126446766, 626.0577830365316, 626.4549841637759, 626.6553395632429, 12528.81206781899, 12551.435185416587, 12553.372331383485, 12592.370381480981, 12619.747605047847, 11452.770944581145, 11638.243514171552, 11901.761964760743, 12191.817122743167, 12204.877951220551, 9422.057794220591, 9583.0, 9588.185004274645, 9699.70900872975, 9735.756606084833, 3178.7933784304178, 3269.4115059289556, 3272.296456261915, 3274.836258187081, 3330.6669333066498, 34424.0, 35397.82301088478, 39000.41499377511, 39394.40908386348, 39562.20875582501, 9605.807883842284, 9652.806943861084, 9725.416475011521, 9768.21854251658, 9930.155936745457, 15938.203089845461, 15938.28277727505, 15975.201239937956, 15984.280707368196, 15994.280257388446, 6441.355864413521, 6465.903011454832, 6529.869402611921, 6634.137562116894, 6647.867042659216, 3302.9339413212083, 3385.509101180315, 3395.5416018837636, 3402.557667503209, 3406.880759173417, 2598.2854714953537, 2650.443406884576, 2655.2830735701255, 2664.1607893513483, 2667.906623268176, 476.4282860567333, 483.079733108429, 487.7366222239951, 489.40781654198815, 494.4733858440749, 488.1774210455323, 533.3466503533141, 540.5729473715799, 549.3517649174013, 593.9703014849326, 7850.646720897574, 7929.167437419103, 7938.682452701943, 7972.402069844785, 8201.548914809742, 487.49057235189315, 540.7809837016015, 617.7096764520668, 618.7957973868613, 629.7512482569451, 3629.927401452009, 3746.4942232798767, 3797.6012518685693, 3800.4299355096405, 3801.7644265613785, 50062.499375005784, 50665.49334506682, 50679.493205067476, 50682.0, 50694.74652626713, 35410.645893540735, 41179.0, 41986.580134198266, 41987.580124198976, 42574.0, 42376.152476950905, 43254.783726081165, 43487.130257394674, 43490.0, 43700.78149609231, 8054.919450805417, 8177.855884012356, 8283.50298982063, 8368.581570921551, 8414.901096490174, 31018.689813102483, 31188.16583429572, 31819.522707159875, 31860.681393185772, 32111.197220069684, 34244.31511369808, 34383.65616343805, 34634.653653463145, 36123.63876361203, 41431.37852932148, 10165.695029149138, 10219.48902554884, 10420.426876521864, 10474.528646210787, 10731.0, 9725.951370243103, 10000.499975001076, 10062.044105809937, 11521.82717259225, 11639.243449175776, 9681.515924203903, 9695.466749328854, 9705.12653861156, 9791.216702663913, 10048.497575121068, 9420.62317507292, 9559.904400955902, 9569.0, 9641.132298093205, 9674.75813104678, 9725.708228753148, 9791.46146961924, 9820.607175713178, 9839.754006149617, 10165.0, 8187.181281871765, 8215.0, 8404.537750423786, 8466.957665211634, 8588.26999705032, 8097.514149151069, 8341.958290208753, 8426.452280601741, 8516.318694504302, 8602.78493037679], "unit": "score", "name": "yui.html", "value": 5663.909861734487}], "name": "dromaeo_css", "value": 6151.069080992611}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 114.0, 107.0, 113.0, 112.0, 113.0, 102.0, 114.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [160.0, 141.0, 151.0, 179.0, 137.0, 163.0, 157.0, 141.0, 189.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 155.5}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 162.0, 161.0, 160.0, 162.0, 162.0, 163.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 104.0, 95.0, 73.0, 75.0, 74.0, 112.0, 95.0, 74.0], "unit": "score", "name": "audio-fft", "value": 84.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 135.0, 95.0, 95.0, 94.0, 137.0, 95.0, 96.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 68.0, 68.0, 68.0, 67.0, 78.0, 65.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 68.5}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 69.0, 70.0, 70.0, 71.0, 71.0, 70.0, 70.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.3}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 82.0, 82.0, 82.0, 81.0, 81.0, 82.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [125.0, 124.0, 129.0, 122.0, 130.0, 122.0, 120.0, 122.0, 121.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.4}, {"lowerIsBetter": true, "replicates": [142.0, 147.0, 148.0, 153.0, 153.0, 135.0, 148.0, 147.0, 151.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.3}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 74.0, 72.0, 71.0, 72.0, 70.0, 72.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.4}], "name": "kraken", "value": 1542.1000000000001}]} 17:31:12 INFO - Return code: 0 17:31:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:31:12 ERROR - # TBPL SUCCESS # 17:31:12 INFO - Running post-action listener: _resource_record_post_action 17:31:12 INFO - Running post-run listener: _resource_record_post_run 17:31:13 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 522014720; Read time: 384; Write time: 515068 17:31:13 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 233807872; Read time: 136; Write time: 322652 17:31:13 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288206848; Read time: 248; Write time: 192416 17:31:13 INFO - Running post-run listener: _upload_blobber_files 17:31:13 INFO - Blob upload gear active. 17:31:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:31:13 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 17:31:13 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'] 17:31:13 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 17:31:13 INFO - (blobuploader) - INFO - Open directory for files ... 17:31:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:31:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:31:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:14 INFO - (blobuploader) - INFO - Done attempting. 17:31:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:31:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:31:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:15 INFO - (blobuploader) - INFO - Done attempting. 17:31:15 INFO - (blobuploader) - INFO - Iteration through files over. 17:31:15 INFO - Return code: 0 17:31:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:31:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:31:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c22d973dd4eede0e9cf113d319811b3264eee3c30c804daa861bc10235b6dbdae79e93cf6326db21ba023839031c82063214d9a903354fe15e3468c7e48d7d81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2fe7ba01c2d9b347b1d1d197315f8e03eddb96bcdace7f3550a0f5307075d38022bae4b7fe7ea7063de3e4c52c1ffd878d8861d7017d5d2f05346c58a28f3872"} 17:31:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:31:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:31:15 INFO - Contents: 17:31:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c22d973dd4eede0e9cf113d319811b3264eee3c30c804daa861bc10235b6dbdae79e93cf6326db21ba023839031c82063214d9a903354fe15e3468c7e48d7d81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2fe7ba01c2d9b347b1d1d197315f8e03eddb96bcdace7f3550a0f5307075d38022bae4b7fe7ea7063de3e4c52c1ffd878d8861d7017d5d2f05346c58a28f3872"} 17:31:15 INFO - Running post-run listener: copy_logs_to_upload_dir 17:31:15 INFO - Copying logs to upload dir... 17:31:15 INFO - mkdir: /builds/slave/test/build/upload/logs 17:31:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.390083 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-09 17:31:15.165540) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 17:31:15.169378) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606 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/c22d973dd4eede0e9cf113d319811b3264eee3c30c804daa861bc10235b6dbdae79e93cf6326db21ba023839031c82063214d9a903354fe15e3468c7e48d7d81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2fe7ba01c2d9b347b1d1d197315f8e03eddb96bcdace7f3550a0f5307075d38022bae4b7fe7ea7063de3e4c52c1ffd878d8861d7017d5d2f05346c58a28f3872"} build_url:https://queue.taskcluster.net/v1/task/SqkwYjSKT6mUVaN3w2bSQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011432 build_url: 'https://queue.taskcluster.net/v1/task/SqkwYjSKT6mUVaN3w2bSQw/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/c22d973dd4eede0e9cf113d319811b3264eee3c30c804daa861bc10235b6dbdae79e93cf6326db21ba023839031c82063214d9a903354fe15e3468c7e48d7d81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2fe7ba01c2d9b347b1d1d197315f8e03eddb96bcdace7f3550a0f5307075d38022bae4b7fe7ea7063de3e4c52c1ffd878d8861d7017d5d2f05346c58a28f3872"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 17:31:15.197600) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 17:31:15.198186) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1457572238.261129-355882606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 17:31:15.280166) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 17:31:15.280524) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 17:31:15.280866) ========= ========= Total master_lag: 0.28 =========