builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1460504660.33 results: success (0) buildid: 20160412152850 builduid: 071f7d34d7264e44b2e2c1f82f597bc0 revision: fb125ff927eae1b7adb8d0e3db798c341d71d8ab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:20.326648) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:20.327069) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:20.327367) ========= 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=41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006380 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:20.351529) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:20.351800) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:20.371204) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:20.371477) ========= 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=41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:20.421832) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:20.422096) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:20.422466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:20.422739) ========= 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=41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-12 16:44:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.9M=0s 2016-04-12 16:44:20 (96.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175090 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:20.613737) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:20.614035) ========= 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=41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013564 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:20.663841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:20.664148) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fb125ff927eae1b7adb8d0e3db798c341d71d8ab --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev fb125ff927eae1b7adb8d0e3db798c341d71d8ab --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=41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-12 16:44:20,906 truncating revision to first 12 chars 2016-04-12 16:44:20,906 Setting DEBUG logging. 2016-04-12 16:44:20,906 attempt 1/10 2016-04-12 16:44:20,906 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fb125ff927ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 16:44:21,451 unpacking tar archive at: mozilla-central-fb125ff927ea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.809431 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:21.486408) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:21.486741) ========= echo fb125ff927eae1b7adb8d0e3db798c341d71d8ab in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'fb125ff927eae1b7adb8d0e3db798c341d71d8ab'] 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=41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False fb125ff927eae1b7adb8d0e3db798c341d71d8ab program finished with exit code 0 elapsedTime=0.004532 script_repo_revision: 'fb125ff927eae1b7adb8d0e3db798c341d71d8ab' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:21.537017) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:21.537334) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 16:44:21.547129) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-04-12 16:44:21.547462) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:44:21 INFO - MultiFileLogger online at 20160412 16:44:21 in /builds/slave/test 16:44:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:44:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:44:21 INFO - {'append_to_log': False, 16:44:21 INFO - 'base_work_dir': '/builds/slave/test', 16:44:21 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:44:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:44:21 INFO - 'branch': 'Firefox-Non-PGO', 16:44:21 INFO - 'buildbot_json_path': 'buildprops.json', 16:44:21 INFO - 'config_files': ('talos/linux_config.py',), 16:44:21 INFO - 'default_actions': ('clobber', 16:44:21 INFO - 'read-buildbot-config', 16:44:21 INFO - 'download-and-extract', 16:44:21 INFO - 'populate-webroot', 16:44:21 INFO - 'create-virtualenv', 16:44:21 INFO - 'install', 16:44:21 INFO - 'run-tests'), 16:44:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:44:21 INFO - 'download_minidump_stackwalk': True, 16:44:21 INFO - 'download_symbols': 'ondemand', 16:44:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:44:21 INFO - 'tooltool.py': '/tools/tooltool.py', 16:44:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:44:21 INFO - '/tools/misc-python/virtualenv.py')}, 16:44:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:44:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:44:21 INFO - 'installer_path': 'installer.exe', 16:44:21 INFO - 'log_level': 'info', 16:44:21 INFO - 'log_name': 'talos', 16:44:21 INFO - 'log_to_console': True, 16:44:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:44:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:44:21 INFO - 'opt_config_files': (), 16:44:21 INFO - 'pip_index': False, 16:44:21 INFO - 'sps_profile': False, 16:44:21 INFO - 'sps_profile_interval': 0, 16:44:21 INFO - 'suite': 'dromaeojs', 16:44:21 INFO - 'system_bits': '32', 16:44:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:44:21 INFO - 'title': 'talos-linux64-ix-026', 16:44:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:44:21 INFO - 'use_talos_json': True, 16:44:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:44:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:44:21 INFO - 'work_dir': 'build'} 16:44:21 INFO - ##### 16:44:21 INFO - ##### Running clobber step. 16:44:21 INFO - ##### 16:44:21 INFO - Running pre-action listener: _resource_record_pre_action 16:44:21 INFO - Running main action method: clobber 16:44:21 INFO - rmtree: /builds/slave/test/build 16:44:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:44:22 INFO - Running post-action listener: _resource_record_post_action 16:44:22 INFO - ##### 16:44:22 INFO - ##### Running read-buildbot-config step. 16:44:22 INFO - ##### 16:44:22 INFO - Running pre-action listener: _resource_record_pre_action 16:44:22 INFO - Running main action method: read_buildbot_config 16:44:22 INFO - Using buildbot properties: 16:44:22 INFO - { 16:44:22 INFO - "project": "", 16:44:22 INFO - "product": "firefox", 16:44:22 INFO - "script_repo_revision": "production", 16:44:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:44:22 INFO - "repository": "", 16:44:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:44:22 INFO - "buildid": "20160412152850", 16:44:22 INFO - "pgo_build": "False", 16:44:22 INFO - "basedir": "/builds/slave/test", 16:44:22 INFO - "buildnumber": 469, 16:44:22 INFO - "slavename": "talos-linux64-ix-026", 16:44:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:44:22 INFO - "platform": "ubuntu64_hw", 16:44:22 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:44:22 INFO - "branch": "mozilla-central", 16:44:22 INFO - "repo_path": "mozilla-central", 16:44:22 INFO - "revision": "fb125ff927eae1b7adb8d0e3db798c341d71d8ab", 16:44:22 INFO - "stage_platform": "linux64", 16:44:22 INFO - "builduid": "071f7d34d7264e44b2e2c1f82f597bc0", 16:44:22 INFO - "slavebuilddir": "test" 16:44:22 INFO - } 16:44:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 16:44:22 INFO - Running post-action listener: _resource_record_post_action 16:44:22 INFO - ##### 16:44:22 INFO - ##### Running download-and-extract step. 16:44:22 INFO - ##### 16:44:22 INFO - Running pre-action listener: _resource_record_pre_action 16:44:22 INFO - Running main action method: download_and_extract 16:44:22 INFO - mkdir: /builds/slave/test/build/tests 16:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:22 INFO - https://queue.taskcluster.net/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:44:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:44:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:44:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/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 16:44:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/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 16:44:31 INFO - Downloaded 1361 bytes. 16:44:31 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:44:31 INFO - Using the following test package requirements: 16:44:31 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:44:31 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:44:31 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:44:31 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:31 INFO - u'jsshell-linux-x86_64.zip'], 16:44:31 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:44:31 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:44:31 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:44:31 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:44:31 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:44:31 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:44:31 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:44:31 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')]} 16:44:31 INFO - https://queue.taskcluster.net/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:44:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:44:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:44:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/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 16:44:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/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 16:44:40 INFO - Downloaded 22197346 bytes. 16:44:40 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'] 16:44:40 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 16:44:41 INFO - Return code: 0 16:44:41 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 16:44:41 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')]} 16:44:41 INFO - https://queue.taskcluster.net/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:44:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:44:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:44:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/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 16:44:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/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 16:44:44 INFO - Downloaded 22197346 bytes. 16:44:44 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'] 16:44:44 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 16:44:45 INFO - Return code: 0 16:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:45 INFO - https://queue.taskcluster.net/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:44:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:44:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:44:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/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 16:44:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/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 16:44:46 INFO - Downloaded 10841076 bytes. 16:44:46 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'] 16:44:46 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 16:44:47 INFO - Return code: 0 16:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:47 INFO - https://queue.taskcluster.net/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:44:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:44:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:44:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/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 16:44:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9Fi-2QKTs2hQI84fb1ASw/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 16:44:48 INFO - Downloaded 54118819 bytes. 16:44:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:44:48 INFO - mkdir: /builds/slave/test/properties 16:44:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:44:48 INFO - Writing to file /builds/slave/test/properties/build_url 16:44:48 INFO - Contents: 16:44:48 INFO - build_url:https://queue.taskcluster.net/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:44:49 INFO - Running post-action listener: _resource_record_post_action 16:44:49 INFO - Running post-action listener: set_extra_try_arguments 16:44:49 INFO - ##### 16:44:49 INFO - ##### Running populate-webroot step. 16:44:49 INFO - ##### 16:44:49 INFO - Running pre-action listener: _resource_record_pre_action 16:44:49 INFO - Running main action method: populate_webroot 16:44:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:44:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:44:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:44:49 INFO - '--tppagecycles', 16:44:49 INFO - '7'], 16:44:49 INFO - 'tests': ['tsvgm']}}, 16:44:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:44:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:44:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:44:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:44:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:44:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:44:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:49 INFO - 'talos_options': ['--disable-e10s'], 16:44:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:44:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:44:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:49 INFO - 'talos_options': ['--disable-e10s'], 16:44:49 INFO - 'tests': ['damp', 'tps']}, 16:44:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:49 INFO - 'tests': ['damp', 'tps']}, 16:44:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:44:49 INFO - 'tests': ['dromaeo_dom']}, 16:44:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:44:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:44:49 INFO - 'tests': ['a11yr', 16:44:49 INFO - 'ts_paint', 16:44:49 INFO - 'tpaint', 16:44:49 INFO - 'sessionrestore', 16:44:49 INFO - 'sessionrestore_no_auto_restore', 16:44:49 INFO - 'tabpaint']}, 16:44:49 INFO - 'other-e10s': {'tests': ['a11yr', 16:44:49 INFO - 'ts_paint', 16:44:49 INFO - 'tpaint', 16:44:49 INFO - 'sessionrestore', 16:44:49 INFO - 'sessionrestore_no_auto_restore', 16:44:49 INFO - 'tabpaint']}, 16:44:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:44:49 INFO - 'ts_paint', 16:44:49 INFO - 'tpaint', 16:44:49 INFO - 'sessionrestore', 16:44:49 INFO - 'sessionrestore_no_auto_restore', 16:44:49 INFO - 'tabpaint']}, 16:44:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:44:49 INFO - 'ts_paint', 16:44:49 INFO - 'tpaint', 16:44:49 INFO - 'sessionrestore', 16:44:49 INFO - 'sessionrestore_no_auto_restore', 16:44:49 INFO - 'tabpaint']}, 16:44:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:44:49 INFO - 'tests': ['a11yr', 16:44:49 INFO - 'ts_paint', 16:44:49 INFO - 'tpaint', 16:44:49 INFO - 'sessionrestore', 16:44:49 INFO - 'sessionrestore_no_auto_restore', 16:44:49 INFO - 'tabpaint']}, 16:44:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:44:49 INFO - 'tests': ['a11yr', 16:44:49 INFO - 'ts_paint', 16:44:49 INFO - 'tpaint', 16:44:49 INFO - 'sessionrestore', 16:44:49 INFO - 'sessionrestore_no_auto_restore', 16:44:49 INFO - 'tabpaint']}, 16:44:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:44:49 INFO - 'tests': ['tsvgx', 16:44:49 INFO - 'tsvgr_opacity', 16:44:49 INFO - 'tart', 16:44:49 INFO - 'tscrollx', 16:44:49 INFO - 'cart']}, 16:44:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:44:49 INFO - 'tsvgr_opacity', 16:44:49 INFO - 'tart', 16:44:49 INFO - 'tscrollx', 16:44:49 INFO - 'cart']}, 16:44:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:49 INFO - 'talos_options': ['--disable-e10s'], 16:44:49 INFO - 'tests': ['tp5o']}, 16:44:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:49 INFO - 'tests': ['tp5o']}, 16:44:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:49 INFO - 'talos_options': ['--disable-e10s', 16:44:49 INFO - '--xperf_path', 16:44:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:44:49 INFO - 'tests': ['tp5n']}, 16:44:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:49 INFO - 'talos_options': ['--xperf_path', 16:44:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:44:49 INFO - 'tests': ['tp5n']}}, 16:44:49 INFO - 'talos.zip': {'path': '', 16:44:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:44:49 INFO - Running post-action listener: _resource_record_post_action 16:44:49 INFO - ##### 16:44:49 INFO - ##### Running create-virtualenv step. 16:44:49 INFO - ##### 16:44:49 INFO - Running pre-action listener: _resource_record_pre_action 16:44:49 INFO - Running main action method: create_virtualenv 16:44:49 INFO - Creating virtualenv /builds/slave/test/build/venv 16:44:49 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 16:44:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:44:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:44:49 INFO - Using real prefix '/usr' 16:44:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:44:49 INFO - Installing distribute.............................................................................................................................................................................................done. 16:44:51 INFO - Installing pip.................done. 16:44:51 INFO - Return code: 0 16:44:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:44:51 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')]} 16:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:51 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')]} 16:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:51 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 0x7f3eccae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2410>, '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 0x1ad3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad37a0>, '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': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', '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 16:44:51 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 16:44:51 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 16:44:51 INFO - Using env: {'DISPLAY': ':0', 16:44:51 INFO - 'HOME': '/home/cltbld', 16:44:51 INFO - 'LANG': 'en_US.UTF-8', 16:44:51 INFO - 'LANGUAGE': 'en_US:en', 16:44:51 INFO - 'LOGNAME': 'cltbld', 16:44:51 INFO - 'MAIL': '/var/mail/cltbld', 16:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:51 INFO - 'MOZ_NO_REMOTE': '1', 16:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:51 INFO - 'NO_EM_RESTART': '1', 16:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:51 INFO - 'PWD': '/builds/slave/test', 16:44:51 INFO - 'SHELL': '/bin/bash', 16:44:51 INFO - 'SHLVL': '1', 16:44:51 INFO - 'TERM': 'linux', 16:44:51 INFO - 'TMOUT': '86400', 16:44:51 INFO - 'USER': 'cltbld', 16:44:51 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', 16:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:51 INFO - '_': '/tools/buildbot/bin/python'} 16:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:51 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 16:44:51 INFO - Cleaning up... 16:44:51 INFO - Return code: 0 16:44:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:44:51 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')]} 16:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:51 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')]} 16:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:51 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 0x7f3eccae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2410>, '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 0x1ad3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad37a0>, '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': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', '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 16:44:51 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 16:44:51 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 16:44:51 INFO - Using env: {'DISPLAY': ':0', 16:44:51 INFO - 'HOME': '/home/cltbld', 16:44:51 INFO - 'LANG': 'en_US.UTF-8', 16:44:51 INFO - 'LANGUAGE': 'en_US:en', 16:44:51 INFO - 'LOGNAME': 'cltbld', 16:44:51 INFO - 'MAIL': '/var/mail/cltbld', 16:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:51 INFO - 'MOZ_NO_REMOTE': '1', 16:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:51 INFO - 'NO_EM_RESTART': '1', 16:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:51 INFO - 'PWD': '/builds/slave/test', 16:44:51 INFO - 'SHELL': '/bin/bash', 16:44:51 INFO - 'SHLVL': '1', 16:44:51 INFO - 'TERM': 'linux', 16:44:51 INFO - 'TMOUT': '86400', 16:44:51 INFO - 'USER': 'cltbld', 16:44:51 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', 16:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:51 INFO - '_': '/tools/buildbot/bin/python'} 16:44:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:52 INFO - Downloading/unpacking psutil>=0.7.1 16:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:44:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:54 INFO - Installing collected packages: psutil 16:44:54 INFO - Running setup.py install for psutil 16:44:54 INFO - building 'psutil._psutil_linux' extension 16:44:54 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 16:44:54 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 16:44:54 INFO - building 'psutil._psutil_posix' extension 16:44:54 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 16:44:54 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 16:44:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:54 INFO - Successfully installed psutil 16:44:54 INFO - Cleaning up... 16:44:54 INFO - Return code: 0 16:44:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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', '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 0x7f3eccae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2410>, '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 0x1ad3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad37a0>, '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': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', '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 16:44: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:44: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 mozsystemmonitor==0.0.0 16:44:54 INFO - Using env: {'DISPLAY': ':0', 16:44:54 INFO - 'HOME': '/home/cltbld', 16:44:54 INFO - 'LANG': 'en_US.UTF-8', 16:44:54 INFO - 'LANGUAGE': 'en_US:en', 16:44:54 INFO - 'LOGNAME': 'cltbld', 16:44:54 INFO - 'MAIL': '/var/mail/cltbld', 16:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:54 INFO - 'MOZ_NO_REMOTE': '1', 16:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:54 INFO - 'NO_EM_RESTART': '1', 16:44:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:54 INFO - 'PWD': '/builds/slave/test', 16:44:54 INFO - 'SHELL': '/bin/bash', 16:44:54 INFO - 'SHLVL': '1', 16:44:54 INFO - 'TERM': 'linux', 16:44:54 INFO - 'TMOUT': '86400', 16:44:54 INFO - 'USER': 'cltbld', 16:44:54 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', 16:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:54 INFO - '_': '/tools/buildbot/bin/python'} 16:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:44:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:44:56 INFO - Installing collected packages: mozsystemmonitor 16:44:56 INFO - Running setup.py install for mozsystemmonitor 16:44:56 INFO - Successfully installed mozsystemmonitor 16:44:56 INFO - Cleaning up... 16:44:56 INFO - Return code: 0 16:44:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:44:56 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')]} 16:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:56 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')]} 16:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:56 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 0x7f3eccae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2410>, '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 0x1ad3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad37a0>, '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': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', '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 16:44:56 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 16:44:56 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 16:44:56 INFO - Using env: {'DISPLAY': ':0', 16:44:56 INFO - 'HOME': '/home/cltbld', 16:44:56 INFO - 'LANG': 'en_US.UTF-8', 16:44:56 INFO - 'LANGUAGE': 'en_US:en', 16:44:56 INFO - 'LOGNAME': 'cltbld', 16:44:56 INFO - 'MAIL': '/var/mail/cltbld', 16:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:56 INFO - 'MOZ_NO_REMOTE': '1', 16:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:56 INFO - 'NO_EM_RESTART': '1', 16:44:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:56 INFO - 'PWD': '/builds/slave/test', 16:44:56 INFO - 'SHELL': '/bin/bash', 16:44:56 INFO - 'SHLVL': '1', 16:44:56 INFO - 'TERM': 'linux', 16:44:56 INFO - 'TMOUT': '86400', 16:44:56 INFO - 'USER': 'cltbld', 16:44:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', 16:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:56 INFO - '_': '/tools/buildbot/bin/python'} 16:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:57 INFO - Downloading/unpacking blobuploader==1.2.4 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44:59 INFO - Downloading blobuploader-1.2.4.tar.gz 16:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:44:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:44:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44:59 INFO - Downloading docopt-0.6.1.tar.gz 16:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:44:59 INFO - Installing collected packages: blobuploader, requests, docopt 16:44:59 INFO - Running setup.py install for blobuploader 16:44:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:44:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:44:59 INFO - Running setup.py install for requests 16:45:00 INFO - Running setup.py install for docopt 16:45:00 INFO - Successfully installed blobuploader requests docopt 16:45:00 INFO - Cleaning up... 16:45:00 INFO - Return code: 0 16:45:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45:00 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')]} 16:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:00 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')]} 16:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:00 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 0x7f3eccae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2410>, '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 0x1ad3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad37a0>, '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': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', '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 16:45:00 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 16:45:00 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 16:45:00 INFO - Using env: {'DISPLAY': ':0', 16:45:00 INFO - 'HOME': '/home/cltbld', 16:45:00 INFO - 'LANG': 'en_US.UTF-8', 16:45:00 INFO - 'LANGUAGE': 'en_US:en', 16:45:00 INFO - 'LOGNAME': 'cltbld', 16:45:00 INFO - 'MAIL': '/var/mail/cltbld', 16:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:00 INFO - 'MOZ_NO_REMOTE': '1', 16:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:00 INFO - 'NO_EM_RESTART': '1', 16:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:00 INFO - 'PWD': '/builds/slave/test', 16:45:00 INFO - 'SHELL': '/bin/bash', 16:45:00 INFO - 'SHLVL': '1', 16:45:00 INFO - 'TERM': 'linux', 16:45:00 INFO - 'TMOUT': '86400', 16:45:00 INFO - 'USER': 'cltbld', 16:45:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', 16:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:00 INFO - '_': '/tools/buildbot/bin/python'} 16:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:45:00 INFO - Running setup.py (path:/tmp/pip-UJM6Ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:45:00 INFO - Running setup.py (path:/tmp/pip-YFyNtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:45:00 INFO - Running setup.py (path:/tmp/pip-0GB6I9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:45:00 INFO - Running setup.py (path:/tmp/pip-N5yRNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:45:00 INFO - Running setup.py (path:/tmp/pip-K0s3hK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:45:01 INFO - Running setup.py (path:/tmp/pip-8ub98y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:45:01 INFO - Running setup.py (path:/tmp/pip-ED6_PL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:45:01 INFO - Running setup.py (path:/tmp/pip-aJffOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:45:01 INFO - Running setup.py (path:/tmp/pip-aNj2aA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:45:01 INFO - Running setup.py (path:/tmp/pip-IpE4mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:45:01 INFO - Running setup.py (path:/tmp/pip-X74sPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:45:01 INFO - Running setup.py (path:/tmp/pip-tDk3Gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:45:01 INFO - Running setup.py (path:/tmp/pip-BwWG_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:45:01 INFO - Running setup.py (path:/tmp/pip-Lls_oG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:01 INFO - Running setup.py (path:/tmp/pip-eUuIsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:45:01 INFO - Running setup.py (path:/tmp/pip-0_u4ML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:45:01 INFO - Running setup.py (path:/tmp/pip-EegmnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:45:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:45:01 INFO - Running setup.py install for manifestparser 16:45:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:45:01 INFO - Running setup.py install for mozcrash 16:45:02 INFO - Running setup.py install for mozdebug 16:45:02 INFO - Running setup.py install for mozdevice 16:45:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:45:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:45:02 INFO - Running setup.py install for mozfile 16:45:02 INFO - Running setup.py install for mozhttpd 16:45:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:45:02 INFO - Running setup.py install for mozinfo 16:45:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:45:02 INFO - Running setup.py install for mozInstall 16:45:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:45:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:45:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:45:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:45:02 INFO - Running setup.py install for mozleak 16:45:02 INFO - Running setup.py install for mozlog 16:45:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:45:02 INFO - Running setup.py install for moznetwork 16:45:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:45:03 INFO - Running setup.py install for mozprocess 16:45:03 INFO - Running setup.py install for mozprofile 16:45:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:45:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:45:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:45:03 INFO - Running setup.py install for mozrunner 16:45:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:45:03 INFO - Running setup.py install for mozscreenshot 16:45:03 INFO - Running setup.py install for moztest 16:45:03 INFO - Running setup.py install for mozversion 16:45:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:45:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:45:03 INFO - Cleaning up... 16:45:03 INFO - Return code: 0 16:45:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:03 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 0x7f3eccae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2410>, '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 0x1ad3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad37a0>, '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': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', '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 16:45:03 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 16:45:03 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 16:45:03 INFO - Using env: {'DISPLAY': ':0', 16:45:03 INFO - 'HOME': '/home/cltbld', 16:45:03 INFO - 'LANG': 'en_US.UTF-8', 16:45:03 INFO - 'LANGUAGE': 'en_US:en', 16:45:03 INFO - 'LOGNAME': 'cltbld', 16:45:03 INFO - 'MAIL': '/var/mail/cltbld', 16:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:03 INFO - 'MOZ_NO_REMOTE': '1', 16:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:03 INFO - 'NO_EM_RESTART': '1', 16:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:03 INFO - 'PWD': '/builds/slave/test', 16:45:03 INFO - 'SHELL': '/bin/bash', 16:45:03 INFO - 'SHLVL': '1', 16:45:03 INFO - 'TERM': 'linux', 16:45:03 INFO - 'TMOUT': '86400', 16:45:03 INFO - 'USER': 'cltbld', 16:45:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', 16:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:03 INFO - '_': '/tools/buildbot/bin/python'} 16:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:45:03 INFO - Running setup.py (path:/tmp/pip-TKbpAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:45:03 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)) 16:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:45:03 INFO - Running setup.py (path:/tmp/pip-sEfZVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:45:04 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)) 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:45:04 INFO - Running setup.py (path:/tmp/pip-0PCeMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:45:04 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)) 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:45:04 INFO - Running setup.py (path:/tmp/pip-cMkN9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:45:04 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)) 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:45:04 INFO - Running setup.py (path:/tmp/pip-HsPPvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:45:04 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)) 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:45:04 INFO - Running setup.py (path:/tmp/pip-yuwDyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:45:04 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)) 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:45:04 INFO - Running setup.py (path:/tmp/pip-zdGQOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:45:04 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)) 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:45:04 INFO - Running setup.py (path:/tmp/pip-1W5uZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:45:04 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)) 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:45:04 INFO - Running setup.py (path:/tmp/pip-homzjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:45:04 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)) 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:45:04 INFO - Running setup.py (path:/tmp/pip-6SwFyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:45:04 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)) 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:45:04 INFO - Running setup.py (path:/tmp/pip-rXoZwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:45:04 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)) 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:45:04 INFO - Running setup.py (path:/tmp/pip-G9KEmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:45:04 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)) 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:45:04 INFO - Running setup.py (path:/tmp/pip-eCJ_1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:45:04 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)) 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:45:04 INFO - Running setup.py (path:/tmp/pip-fb77St-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:45:04 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)) 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:04 INFO - Running setup.py (path:/tmp/pip-FeQe2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:04 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)) 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:45:04 INFO - Running setup.py (path:/tmp/pip-ON5AxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:45:05 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)) 16:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:45:05 INFO - Running setup.py (path:/tmp/pip-2A_cpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:45:05 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)) 16:45:05 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)) 16:45:05 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)) 16:45:05 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)) 16:45:05 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)) 16:45:05 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)) 16:45:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:45:05 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 16:45:05 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 16:45:05 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 16:45:05 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 16:45:05 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 16:45:05 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 16:45:06 INFO - Downloading blessings-1.6.tar.gz 16:45:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:45:07 INFO - Installing collected packages: blessings 16:45:07 INFO - Running setup.py install for blessings 16:45:07 INFO - Successfully installed blessings 16:45:07 INFO - Cleaning up... 16:45:07 INFO - Return code: 0 16:45:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:45:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:45:07 INFO - Reading from file tmpfile_stdout 16:45:07 INFO - Current package versions: 16:45:07 INFO - argparse == 1.2.1 16:45:07 INFO - blessings == 1.6 16:45:07 INFO - blobuploader == 1.2.4 16:45:07 INFO - docopt == 0.6.1 16:45:07 INFO - manifestparser == 1.1 16:45:07 INFO - mozInstall == 1.12 16:45:07 INFO - mozcrash == 0.17 16:45:07 INFO - mozdebug == 0.1 16:45:07 INFO - mozdevice == 0.48 16:45:07 INFO - mozfile == 1.2 16:45:07 INFO - mozhttpd == 0.7 16:45:07 INFO - mozinfo == 0.9 16:45:07 INFO - mozleak == 0.1 16:45:07 INFO - mozlog == 3.1 16:45:07 INFO - moznetwork == 0.27 16:45:07 INFO - mozprocess == 0.22 16:45:07 INFO - mozprofile == 0.28 16:45:07 INFO - mozrunner == 6.11 16:45:07 INFO - mozscreenshot == 0.1 16:45:07 INFO - mozsystemmonitor == 0.0 16:45:07 INFO - moztest == 0.7 16:45:07 INFO - mozversion == 1.4 16:45:07 INFO - psutil == 3.1.1 16:45:07 INFO - requests == 1.2.3 16:45:07 INFO - wsgiref == 0.1.2 16:45:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:07 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 0x7f3eccae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2410>, '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 0x1ad3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad37a0>, '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': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', '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 16:45:07 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 16:45:07 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 16:45:07 INFO - Using env: {'DISPLAY': ':0', 16:45:07 INFO - 'HOME': '/home/cltbld', 16:45:07 INFO - 'LANG': 'en_US.UTF-8', 16:45:07 INFO - 'LANGUAGE': 'en_US:en', 16:45:07 INFO - 'LOGNAME': 'cltbld', 16:45:07 INFO - 'MAIL': '/var/mail/cltbld', 16:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:07 INFO - 'MOZ_NO_REMOTE': '1', 16:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:07 INFO - 'NO_EM_RESTART': '1', 16:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:07 INFO - 'PWD': '/builds/slave/test', 16:45:07 INFO - 'SHELL': '/bin/bash', 16:45:07 INFO - 'SHLVL': '1', 16:45:07 INFO - 'TERM': 'linux', 16:45:07 INFO - 'TMOUT': '86400', 16:45:07 INFO - 'USER': 'cltbld', 16:45:07 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', 16:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:07 INFO - '_': '/tools/buildbot/bin/python'} 16:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:07 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)) 16:45:07 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)) 16:45:07 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)) 16:45:07 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)) 16:45:07 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)) 16:45:07 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)) 16:45:07 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)) 16:45:07 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)) 16:45:07 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)) 16:45:07 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)) 16:45:07 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)) 16:45:07 INFO - Cleaning up... 16:45:07 INFO - Return code: 0 16:45:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3eccae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2410>, '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 0x1ad3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad37a0>, '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': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', '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 16:45:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:45:07 INFO - Using env: {'DISPLAY': ':0', 16:45:07 INFO - 'HOME': '/home/cltbld', 16:45:07 INFO - 'LANG': 'en_US.UTF-8', 16:45:07 INFO - 'LANGUAGE': 'en_US:en', 16:45:07 INFO - 'LOGNAME': 'cltbld', 16:45:07 INFO - 'MAIL': '/var/mail/cltbld', 16:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:07 INFO - 'MOZ_NO_REMOTE': '1', 16:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:07 INFO - 'NO_EM_RESTART': '1', 16:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:07 INFO - 'PWD': '/builds/slave/test', 16:45:07 INFO - 'SHELL': '/bin/bash', 16:45:07 INFO - 'SHLVL': '1', 16:45:07 INFO - 'TERM': 'linux', 16:45:07 INFO - 'TMOUT': '86400', 16:45:07 INFO - 'USER': 'cltbld', 16:45:07 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', 16:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:07 INFO - '_': '/tools/buildbot/bin/python'} 16:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:07 INFO - Downloading/unpacking jsonschema 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:45:09 INFO - Downloading/unpacking functools32 (from jsonschema) 16:45:09 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 16:45:09 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 16:45:09 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 16:45:09 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 16:45:09 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 16:45:09 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 16:45:09 INFO - Downloading functools32-3.2.3-2.tar.gz 16:45:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:45:10 INFO - warning: no files found matching '*.txt' 16:45:10 INFO - no previously-included directories found matching 'build' 16:45:10 INFO - no previously-included directories found matching 'dist' 16:45:10 INFO - no previously-included directories found matching '.git*' 16:45:10 INFO - Installing collected packages: jsonschema, functools32 16:45:10 INFO - Running setup.py install for functools32 16:45:10 INFO - warning: no files found matching '*.txt' 16:45:10 INFO - no previously-included directories found matching 'build' 16:45:10 INFO - no previously-included directories found matching 'dist' 16:45:10 INFO - no previously-included directories found matching '.git*' 16:45:10 INFO - Successfully installed jsonschema functools32 16:45:10 INFO - Cleaning up... 16:45:10 INFO - Return code: 0 16:45:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3eccae8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a435a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad2410>, '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 0x1ad3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad37a0>, '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': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', '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 16:45: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', 'flake8'] in /builds/slave/test/build 16:45: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 flake8 16:45:10 INFO - Using env: {'DISPLAY': ':0', 16:45:10 INFO - 'HOME': '/home/cltbld', 16:45:10 INFO - 'LANG': 'en_US.UTF-8', 16:45:10 INFO - 'LANGUAGE': 'en_US:en', 16:45:10 INFO - 'LOGNAME': 'cltbld', 16:45:10 INFO - 'MAIL': '/var/mail/cltbld', 16:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:10 INFO - 'MOZ_NO_REMOTE': '1', 16:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:10 INFO - 'NO_EM_RESTART': '1', 16:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:10 INFO - 'PWD': '/builds/slave/test', 16:45:10 INFO - 'SHELL': '/bin/bash', 16:45:10 INFO - 'SHLVL': '1', 16:45:10 INFO - 'TERM': 'linux', 16:45:10 INFO - 'TMOUT': '86400', 16:45:10 INFO - 'USER': 'cltbld', 16:45:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', 16:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:10 INFO - '_': '/tools/buildbot/bin/python'} 16:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:10 INFO - Downloading/unpacking flake8 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:45:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:45:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:45:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:45:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:45:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:45:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:45:13 INFO - no previously-included directories found matching 'docs/_build' 16:45:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:45:13 INFO - Running setup.py install for pep8 16:45:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:45:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:45:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:45:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:45:13 INFO - no previously-included directories found matching 'docs/_build' 16:45:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:45:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:45:13 INFO - Cleaning up... 16:45:13 INFO - Return code: 0 16:45:13 INFO - Running post-action listener: _resource_record_post_action 16:45:13 INFO - Running post-action listener: _start_resource_monitoring 16:45:13 INFO - Starting resource monitoring. 16:45:13 INFO - ##### 16:45:13 INFO - ##### Running install step. 16:45:13 INFO - ##### 16:45:13 INFO - Running pre-action listener: _resource_record_pre_action 16:45:13 INFO - Running main action method: install 16:45:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:45:13 INFO - Reading from file tmpfile_stdout 16:45:13 INFO - Detecting whether we're running mozinstall >=1.0... 16:45:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:45:13 INFO - Reading from file tmpfile_stdout 16:45:13 INFO - Output received: 16:45:13 INFO - Usage: mozinstall [options] installer 16:45:13 INFO - Options: 16:45:13 INFO - -h, --help show this help message and exit 16:45:13 INFO - -d DEST, --destination=DEST 16:45:13 INFO - Directory to install application into. [default: 16:45:13 INFO - "/builds/slave/test"] 16:45:13 INFO - --app=APP Application being installed. [default: firefox] 16:45:13 INFO - mkdir: /builds/slave/test/build/application 16:45:13 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'] 16:45:13 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 16:45:29 INFO - Reading from file tmpfile_stdout 16:45:29 INFO - Output received: 16:45:29 INFO - /builds/slave/test/build/application/firefox/firefox 16:45:29 INFO - Running post-action listener: _resource_record_post_action 16:45:29 INFO - ##### 16:45:29 INFO - ##### Running run-tests step. 16:45:29 INFO - ##### 16:45:29 INFO - Running pre-action listener: _resource_record_pre_action 16:45:29 INFO - Running main action method: run_tests 16:45:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:45:29 INFO - Python 2.7.3 16:45:29 INFO - Return code: 0 16:45:29 INFO - grabbing minidump binary from tooltool 16:45:29 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')]} 16:45:29 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 0x1ad2410>, '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 0x1ad3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ad37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:45:29 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 16:45:29 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 16:45:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:45:29 INFO - Return code: 0 16:45:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:45:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:45:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:45:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:45:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:45:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:45:30 INFO - Return code: 0 16:45:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 16:45:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 16:45:30 INFO - Using env: {'DISPLAY': ':0', 16:45:30 INFO - 'HOME': '/home/cltbld', 16:45:30 INFO - 'LANG': 'en_US.UTF-8', 16:45:30 INFO - 'LANGUAGE': 'en_US:en', 16:45:30 INFO - 'LOGNAME': 'cltbld', 16:45:30 INFO - 'MAIL': '/var/mail/cltbld', 16:45:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:45:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:30 INFO - 'MOZ_NO_REMOTE': '1', 16:45:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:30 INFO - 'NO_EM_RESTART': '1', 16:45:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:30 INFO - 'PWD': '/builds/slave/test', 16:45:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:45:30 INFO - 'SHELL': '/bin/bash', 16:45:30 INFO - 'SHLVL': '1', 16:45:30 INFO - 'TERM': 'linux', 16:45:30 INFO - 'TMOUT': '86400', 16:45:30 INFO - 'USER': 'cltbld', 16:45:30 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510', 16:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:30 INFO - '_': '/tools/buildbot/bin/python'} 16:45:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 16:45:30 INFO - mozversion application_buildid: 20160412152850 16:45:30 INFO - mozversion application_changeset: fb125ff927eae1b7adb8d0e3db798c341d71d8ab 16:45:30 INFO - mozversion application_display_name: Nightly 16:45:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:45:30 INFO - mozversion application_name: Firefox 16:45:30 INFO - mozversion application_remotingname: firefox 16:45:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:45:30 INFO - mozversion application_vendor: Mozilla 16:45:30 INFO - mozversion application_version: 48.0a1 16:45:30 INFO - mozversion platform_buildid: 20160412152850 16:45:30 INFO - mozversion platform_changeset: fb125ff927eae1b7adb8d0e3db798c341d71d8ab 16:45:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:45:30 INFO - mozversion platform_version: 48.0a1 16:45:30 INFO - using testdate: 1460504730 16:45:30 INFO - actual date: 1460504730 16:45:30 INFO - starting webserver on 'localhost:39477' 16:45:30 INFO - SUITE-START | Running 2 tests 16:45:30 INFO - TEST-START | dromaeo_css 16:45:30 INFO - operating with platform_type : linux_ 16:45:30 INFO - Initialising browser for dromaeo_css test... 16:45:30 INFO - TEST-INFO | started process 1698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFIT9la/profile http://localhost:39477/getInfo.html) 16:45:35 INFO - PROCESS | 1698 | __metrics Screen width/height:1600/1200 16:45:35 INFO - PROCESS | 1698 | colorDepth:24 16:45:35 INFO - PROCESS | 1698 | Browser inner width/height: 1024/697 16:45:35 INFO - PROCESS | 1698 | __metrics 16:45:36 ERROR - PROCESS | 1698 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:45:36 INFO - TEST-INFO | 1698: exit 0 16:45:36 INFO - Browser initialized. 16:45:36 INFO - Running cycle 1/1 for dromaeo_css test... 16:45:36 INFO - TEST-INFO | started process 1780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFIT9la/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:45:48 INFO - PROCESS | 1780 | RSS: Main: 154796032 16:45:48 INFO - PROCESS | 1780 | 16:46:40 INFO - PROCESS | 1780 | 1460504800435 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] 16:48:51 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:39477/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39477/tests/dromaeo/cssquery-ext.html) 16:48:52 INFO - PROCESS | 1780 | RSS: Main: 262553600 16:48:52 INFO - PROCESS | 1780 | 16:51:55 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:39477/tests/dromaeo/cssquery-ext.html (next: http://localhost:39477/tests/dromaeo/cssquery-jquery.html) 16:51:56 INFO - PROCESS | 1780 | RSS: Main: 230854656 16:51:56 INFO - PROCESS | 1780 | 16:54:58 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:39477/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39477/tests/dromaeo/cssquery-mootools.html) 16:54:58 INFO - PROCESS | 1780 | RSS: Main: 231804928 16:54:58 INFO - PROCESS | 1780 | 16:58:00 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:39477/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39477/tests/dromaeo/cssquery-prototype.html) 16:58:01 INFO - PROCESS | 1780 | RSS: Main: 219230208 16:58:01 INFO - PROCESS | 1780 | 17:01:04 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:39477/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39477/tests/dromaeo/cssquery-yui.html) 17:01:04 INFO - PROCESS | 1780 | RSS: Main: 213843968 17:01:04 INFO - PROCESS | 1780 | 17:04:07 INFO - PROCESS | 1780 | Cycle 1(1): loaded http://localhost:39477/tests/dromaeo/cssquery-yui.html (next: http://localhost:39477/tests/dromaeo/cssquery-dojo.html) 17:04:07 INFO - PROCESS | 1780 | RSS: Main: 268558336 17:04:07 INFO - PROCESS | 1780 | 17:04:07 INFO - PROCESS | 1780 | __start_tp_report 17:04:07 INFO - PROCESS | 1780 | _x_x_mozilla_page_load 17:04:07 INFO - PROCESS | 1780 | _x_x_mozilla_page_load_details 17:04:07 INFO - PROCESS | 1780 | |i|pagename|runs| 17:04:07 INFO - PROCESS | 1780 | |0;dojo.html;2603.492318997796;2670.3724624713177;2679.5176868163735;2679.825811322263;2702.0137649757844;4505.932411013838;4574.5882870541645;4598.448186217654;4598.494165641777;4606.930896036562;4606.262997920333;4634.629229661619;4657.441107067149;4665.206914824479;4702.0595880823885;4171.979140104295;4193.685473589493;4208.494980602332;4251.574842515754;4391.758453285068;4350.390945267649;4355.629771469429;4363.541828108035;4396.20868243716;4400.251957167289;4121.835126594932;4208.263553878059;4237.364395340693;4296.140771845612;4323;4245.745255284662;4275.0167461483725;4278.165757677254;4281.978590107061;4320.870373888757;4228.238916994939;4236.449261596003;4247.660187185018;4247.830086796555;4293.055527783882;4340.65274778017;4448.872835969611;4476.597106260452;4484.148011877765;4543.5456454354635;4864.878378040542;4891.972685736;4894.535019173173;4897.020595880838;4922.310876477296;4898.412190537123;4929.433115191763;4934.407871055496;4937.950620493785;4980.05378977993;4582.88542786433;4604.217283061854;4604.355390245369;4653.185692503798;4671;5129.076766182048;5129.102407078746;5147.510986456281;5147.613928955343;5160.354955630546;4925.187344088257;4939.506049395031;4942.986687729007;4946.826861059918;5002.399712034579;4857.101436234308;4968.22992436173;5018.222175562793;5060.7722652480725;5066.417362003417;4913.656044076952;4930.161872481687;4932.260160975882;4934.1118598651865;4984.950150498448;4800.95199048012;4898.804047838118;4901.926471102936;4917.385326834145;4958.033183529177;4108.4453598764385;4118.876433706993;4181.477315335583;4182.519010313792;4186.28833098374;3634.5638523376833;3636.090977255686;3664.578573464086;3669.5963444021136;3671.6695497405362;4304.720193187432;4329.848455304049;4340.956590434118;4363.323684828857;4384.320430333303;4842.322074909515;4897.7795999180125;4954.950450495449;4994.150994330972;5024.221245706921;4338.219120558267;4342.5874541918465;4362.498312694017;4381.364702118175;4384.232759267115;4430.800613972379;4435.578620031092;4441.888952776207;4443.666724995638;4490.281554951192;4633.72197668141;4715.316279139574;4727.17274476972;4757.35775670287;4805.735684537384;4949.381327334083;4963.305137280856;4963.677360971526;5004.724740139327;5018.071656743514;4656.906861862812;4701.905961880811;4701.905961880811;4705.317728929354;4755.286706993978;4773.188557945088;4885.071836351082;4901.387326584177;4945.7527123644395;4962.6774259673;4951.876203094951;4962.6774259673;4970.577500912463;4972.8756781080765;5015.072211640858;4814.20565606685;4814.325994360723;4815.590674792542;4854.878628034327;4865.781039853286;4703.459102203154;4767.928481072856;4818.4217893852965;4839.056384005085;4866.318715379921;4725.645576581839;4729.976350118227;4737.976310118427;4738.431388233434;4776.21192503233;4833.202521583899;4836.879078023077;4837.7097374157665;4839.104765618372;4891.095147397743;4583.793729282123;4705.858824235278;4788.808447662054;4844.733539655353;4854.660173787801 17:04:07 INFO - PROCESS | 1780 | |1;ext.html;582.2634367525081;593.8841925824463;615.2739767074853;627.3600927054407;632.4181752787435;32745.50881736773;33430.832845835735;33517.329653406916;33814.66185338146;34891.47662785057;35349.646503534954;36004.819975900085;36047.27905441896;36149.277014459694;36176.2764744705;7188.460865435087;7635.503692260013;7851.882221766649;7859.489133206352;9515.19120874723;9687.079727425884;9878.407295562254;9880.160186384166;9881.160101391355;9888.060634239771;9804.509774511282;9897.703068907907;9900.90099099007;9905.059019393182;9907.653232136876;9814.312998090136;9861.556229969668;9875.061869122494;9881.802363952716;9896.25778066648;9676.806463870684;9760.511974401252;9762.170215531689;9764.365316254421;10029.297949143564;35820.64179358199;36247.81876090629;36296;36296.45555316672;36316;3090.536419537065;3117.688231176887;3252.788568743024;3497.7726447780815;3789.8673546426016;28120.85939570289;28265.717342826516;28299.292517687016;29568.8521557393;30139.849300753354;3343.3480471308103;3353.144948038259;3353.748468864845;3448.793072415638;3566.6433356664384;156234;157610.21194894068;158905;159015;159650;50032.24951625729;52817.471825282024;52834.73582632062;52864.20703689448;52968.73515632397;55526.72236638791;55709.721451392485;55780;55904.440955589926;55910;12879.484820607258;13151.802722959163;13152.802707959388;13157.210567365797;13173.538926137539;9620.567074481665;9746.902530974741;9752.902470975341;9756.756081098029;9761.267904907161;17231.310747569958;18165.091745412676;18218.54453638643;18315.633687326444;18357.816421835876;6684.465242780566;6861.897071543831;7086.681099350541;7107;7227.710891564278;855.8159995600976;902.9345372460559;918.8300164469595;1025.8922813104666;1097.8133717268083;26835.597466038023;27565.86217068942;28185.295367615563;28196.154115376572;28276.15171544857;927.2720914082413;938.0525669074284;949.4872768704822;994.2344394815951;1065.5098654618807;14673.486427974969;14869.256537173314;14947.252637368088;15022.399104035934;15196;301367;531098;546526;547638;548942;47307;47991.28013079806;48381;48410.27384589234;48452;1090.4166271044794;1230.1511956749814;1261.8107283907486;1281.3401098434315;1286.2539726958341;25999.220023399328;28228.15315540537;28864.42271154523;28937.276568085967;29018.564721529616;38486.6151338483;39416.40875386814;39449.60550394459;39486.40770388504;39682;237149;237473;238255;238439;239346;25070.247892563253;25436.49127017486;37493.250134997696;38869.80565097156;39507.60492395039;35946.28107437889;36087.819560902026;36827;37136.81431592825;40769.38845917373;33271.33457330888;33477;33834.66165338315;33918;34853.82573087118;33547.664523354455;33796.831015844764;33913.49129763105;34033;34441.311173776885;30437.391252174388;34276.36445581016;34700.82649586736;35052.64947350494;35236.29527409489;23096.307110786704;29010.854945725136;30750.862034798745;31082.689173108884;31240;24647;25638.487230255665;25771.226863194133;25828.613592852464;26063.478730425664 17:04:07 INFO - PROCESS | 1780 | |2;jquery.html;374.1656106881653;381.6450700848211;382.7167895757141;384.64036126221987;388.42513080640634;10364.740881477957;10895.346279223233;10910.836337454944;10913.454327283644;15474.303656335464;17093.145342732874;17599.120043997813;17831.108444577752;17999.100044997762;18035.36876209333;5513.558915286778;5744.425557444243;5749.195112684228;5750.223719797837;5752.1084231943905;3967.7817720025387;5472.644278121929;6457.257415397243;6842.315768423167;6874.312568743136;6470.773522926698;6834.453243740489;6852.28051054637;6862.451003919699;6863.553868998524;6734.764283250087;6805.183377994623;6830.726770929157;6832.897506537406;6840.692168852389;6138.9693051534905;6540.803775886731;6582.506312026617;6590.538662293641;6591.274959754423;21485.570288594296;21533.24633637815;22261.554768904694;22795.062419694346;22998.54002919932;2026.3515674984012;2043.7751847296934;2101.516651170224;2123.341764053133;2163.383435720812;13834.723305533933;14402.567922962224;14471.638209044753;14527.20100394478;14775;1859.9349022784272;1966.980330196694;1977.2782934228903;1978.3471454420007;2009.9698504522444;75737.62131189364;77379;77882.22117778863;78326;80363.5981820093;15905.115107410333;15923.203839807964;15995.840041599668;16173.838261617233;16939.306069392962;29120.27199320034;29126.85436572846;29427.762946075916;29485.557716634266;29544.261393465335;8016.679332826621;8039.397045221632;8173.100958894517;8232.711855085043;8383.496990180609;6534.509911756542;6584.407403333723;6602.471802255808;6740.83147921296;6744.12326397575;8280.420370574002;8344.791380215544;8442.873356899652;8475.152484751476;8476.770868224074;2783.5268004439295;3092.8400205325397;3395.4567269236804;3419.7435192360176;3546.6985306249258;895.1496078725237;938.4603852784676;944.5654998700675;955.5986485675894;965.6089283840056;15697.372105115668;16181.838181618034;16193.838061619233;16252.674946501003;16542.0901850397;854.1671869926772;860.5181098584812;872.7425409504211;886.3347625853673;952.33812500313;9070.478245235496;9161.770955726028;9295.349325547148;9330.160285574331;9457.243420526342;391998;398619;400752;402644;404574;73248.63375683088;73901.6304918472;74440.62779686175;74663.25336746563;76187.61906190544;901.7835719427421;910.4537277633367;911.8723378726984;916.4180745226829;950.5674917912471;14411.639709007359;14427.639309017359;14525.636859078608;14636.853631463975;14928.850711492745;30740.538891917087;30746.077617671504;31284.687153128176;32757.344853102328;34471.31057378888;42266.788666056476;42874.356884646135;43413.565864340955;43488.78255608702;43986.56013439825;6747.527673063035;6812.318768123148;6935.549189302679;7179.928200718135;7208.27917208275;8568.143469366394;12243.326617035793;12279.938600306941;12293.631191064282;12374.13381063317;10135.442550659785;10416;10603.363798172135;10617.840732388866;10667;10514.474276286002;10579.31234469757;10633;10662.200334975063;10897.29167604135;10295.382277063101;10618.893811061791;10663.4135122569;10671.94664026675;10825.67522974312;6655.101561289358;6999.930000700131;7122.145342558719;7213.783586492414;7463.626818659154;7795.454318197899;9563.904360956301;10287.331323463952;10316.845247321146;10389.792204156025 17:04:07 INFO - PROCESS | 1780 | |3;mootools.html;1210.3827048205412;1449.9130052196865;1504.1276059885265;1670.3235189748157;1834.0646270402099;7258.600776957265;7535.660895259713;7545.584992825399;7550.395968322535;7564.205758395372;7345.559266444017;7473.103227612694;7482.738104166356;7483.812904677386;7489.363404110657;1902.4197619725978;2165.9133634654636;2178.8692678439265;2193.1775584155944;2256.345659758668;2237.776222377757;2255.7293124825046;2256.808171305441;2261.4459457432868;2263.4228271790753;2179.542296117809;2208.63557513011;2222.100049479963;2227.7438094619083;2237.742659594151;1896.3078476356168;2190.0473294117032;2241.529278851443;2251.921182758612;2260.7400148982915;2138.3050508584774;2145.731783527059;2147.7744836792067;2152.1068756466047;2230.1971290335628;7480.027596412431;7522.623868806538;7545.283198096172;7557.47097703161;7581.3176814087;4278.529361770203;4421.292593185107;4436.911261774746;4446.266366049598;4476.7090139140855;2942.2497263197747;2957.2902503399027;3012.322227498795;3067.1718635968164;3076.9230769230726;921.5438358012759;924.2790623313826;935.948522831244;936.2276122199213;950.7100334398006;10478.685639430829;10490.947545262301;10495.42275174865;10503.422311772849;10512.526936287886;4031.274370613318;4254.3831144483875;4278;4429.224885645;4429.7785110744335;8884.777880552909;8943.776405589782;8948.552572371356;8967.820643587222;8975.057618949917;3933.8623148189677;4436.511983681857;4445.2887537993765;4447.355133505624;4449.7330160190495;3681.2821499807815;3689.6310368963427;3691.796951167658;3920.6471417572557;4125.463689720317;3555.6444355564236;3605.3690604144695;3649.872254471081;3659.4144936809985;3739.08392443853;1188.3701638131804;1188.7028242939266;1204.00669447706;1206.843110395643;1208.3173007250875;1195.9222650527688;1212.5513559982862;1228.975420491585;1240.1566934484456;1252.599168266146;7178.282171782885;7229.710811567584;7253.27467253281;7353.889691654629;7359.043324367905;428.88420126565654;436.975966321849;437.0297938576355;440.47583375782716;454.8408057180027;5356.544693701001;5440.891182176334;5706;5782.421757824184;5788.392218816964;8892.377533572717;9023.864642030374;9375.437473751597;9504.477253750973;9514.619415223313;9288;9368.4378937264;9382.390144640576;9415.246780257563;9419.293552983554;6938.479614028867;7283.817904552323;7317.341439270491;7325.2308507607;7334.523255988237;7084.079069720903;7099.396551293198;7162.785116446515;7168;7386.96306518464;8878.156575125353;8912.064233255414;8957.865632015395;8960.118375141294;9033.909660903308;8895;9018.503982281038;9031.645253212071;9139.177474027369;9139.680111196076;6215.316315205233;6562.967185164043;6640.335966403321;6737.69680364375;6873.4157596602845;7407.888881666671;7445.404367650467;7462.067241594801;7469.58917259556;7483.363914067365;6695.196576410862;6868.244493105654;6884.345987131214;6980.965095174694;6983.266756990442;6670.666466676744;6675.899861501985;6681.432078273207;6761.459083273425;6778.93221067783;6965.268646792014;7065.752698655522;7194.136703595602;7255.963720181366;7263.418926485762;6576.605403675795;6630.7679231226675;6689.09697190873;6690.464762818866;6702.765403210864;6689.431398331002;6769.052332673331;6776.491763117688;6777;6781.728730850711 17:04:07 INFO - PROCESS | 1780 | |4;prototype.html;290.2193100559495;297.41706255738757;308.06348699952133;321.5723088292571;321.8342553584903;5021.196608542629;5030.974845125774;5045.167547354687;5085.135526960416;5101.872453188672;5022.372203474566;5028.698278103317;5038.168702164147;5038.798448062083;5044.747762611873;3752.043228976614;3854;3866.420036994445;3979.1444839359533;4034.8184331704997;4012.678985681153;4013.2976729072443;4024.1750441159493;4030.9395359069636;4033.1933613277315;3740.45763364312;3984.242993831163;3992.6207010334115;3995.3008223560905;4005.9198816023663;3740.775553466787;3885.941710874339;3936.389859571771;3947;3951.8419263229434;3460.197240235417;3474.5309383233193;3476.1309672581856;3487.128217945514;3488.843002064888;4840.128776820171;4843.370361852972;4849.612031037508;4849.806007759686;4856.39295088114;4302.204092242945;4537.914218331533;4558.61251793598;4566.246569316058;4583.449986001668;5241.947580524184;5263.210518422229;5271.130263506555;5282.260483532308;5286.233496143038;3858.82635281413;3863.5363756349416;3863.8454461821493;3865.5168103987003;3873.624863173561;5482.068048431776;5537.363203231599;5554.611177217556;5588.1059030555325;5609.411011843779;3969.980150099289;3983.203359328088;3990.2817492851564;3990.8204130814183;3991.7804520751056;4050.8987275317763;4052.7163098582814;4056.1684854604737;4056.8985775355854;4059.715819892638;4455.910881782346;4579.427571553556;4582.381378513925;4586.518415566385;4586.839460618862;5340.946590534123;5360.70516121617;5370.657335666084;5377;5386.48828361305;1400.5168216965335;1419.7799341102145;1421.5664222412056;1426.8287805463203;1427.8215223097113;903.408267584733;933.705882646964;971.4220039076879;985.3644399362371;991.3902949686036;4654.790534425959;4679.836205732783;4735.8342458014495;4741.478437371887;4742.691725037862;5419.918701219485;5449.209864569615;5482.369527504308;5487.5609951203805;5491.505764481216;4627.177421772716;4683.531646835289;4694.483606803249;4748.0978614063215;4756.096341695136;2912.8252304861776;2916.7958242923214;2923.0500087471232;2923.064619321839;2929.091981485746;5146.562542183881;5160.40655324635;5178.8964220716125;5182.689038657692;5189.506996835295;5385.407605163429;5555;5581.609287349927;5602.495775380154;5612.074007788669;5101.719405432663;5134;5136.4606716295;5159.207982133129;5160.690358578498;5418.403975562606;5426.240326354393;5432.619716619957;5440.918386224131;5485.6434331768305;5161.3032240647035;5421.864453388697;5447.4824891635235;5449.128139497661;5474.124140137559;5225.5558277545315;5248.685078895279;5248.947510524846;5251.162093267326;5274.7098909560345;3859.5561510425537;3881.146147847582;3881.971277611379;3882.8446862125197;3892.124272038882;5279.128943724396;5565.471280228372;5566.471185237558;5578.776848925998;5586.664800112007;5328.946710533;5334.893302133858;5352.919706204488;5370.731463426735;5386.8383948481605;5142.485751424828;5340.786368545215;5352.9732351338;5358.035553600389;5358.97320513395;5021.271915572294;5293.497117773805;5295.9470405297;5297.470252974672;5297.602679798953;5152.819651312186;5315.681059136309;5378.811741589026;5388.137897936312;5389.622726409114;5210.609204309616;5245.816396426107;5250.238715386171;5255.973720131375;5275.235090911719 17:04:07 INFO - PROCESS | 1780 | |5;yui.html;740.3706849178197;751.4927423988806;760.3157158557301;780.1067777394883;790.9011373578304;11903.58337458189;12484.875151248485;12509.749805003894;12563.748725025494;12570.811437828439;12988.805167922465;13027.544035958743;13073.346332683375;13112.73774524509;13126.343682815845;645.6352161029004;829.3116713128104;835.7409203147014;836.6820608168887;836.6820608168887;787.4291138924262;819.1930948016229;821.0557858462786;821.4332110843528;821.8109834738013;859.299670768325;859.9914000860006;863.0592654007131;864.2135656552539;865.6018231613465;666.4235436347573;841.7979684875647;855.102142750113;855.8972923249188;856.1994535109661;630.8044506203091;631.2677294338545;631.567376347199;632.6267502173694;633.1168020611221;10893;10922.945385273102;10943.56225750969;10956.726081847937;10960.451977401177;12376.13367064306;12864.871351286462;12893.742125157538;12926.482940682361;12960.740785184244;9998.45008524531;10000.799984000352;10044.246681498917;10132;10203.693889183336;3251.5772949516413;3292.061762397729;3316.8673253069846;3342.0141058387835;3401.234722187513;49853.25220121701;50294.497055029715;50296.24555631705;50817.49182508165;51100.23349649758;9794.608215671293;9839.360441571274;9846.113849753414;9864.457454840052;10000.249981251436;17677.11614419274;17679.38122165718;17702.203400846993;17716.82283177152;17736.379226727004;6723.226828914738;6799.218089919624;6824.488163387766;6879.2432832388395;6941.236463988957;3927.9214415711526;3965.464662270614;3975.0857302820514;4029.81865816039;4052.4731784867777;2898.6086878271585;2970.762339012874;2977.865996030184;2997.80514266572;2998.250437390652;505.6081536809003;508.8651507350555;522.7177324244865;522.7621432248318;524.7507433968834;490.77914938277917;521.59315733727;612.1705089603612;627.4290395739946;638.3999040901538;7607.16321204667;7636.69453221876;7933.682652693828;8066.274035336848;8214.26071653554;542.9801139760086;564.1087082409782;615.7106160104744;620.6493331267819;622.8256088295194;3728.832202550892;3795.658390744791;3834.846606135779;3938.3895496198134;4053.432519447221;42519.57480425156;43939.12121757611;44023;52042;53140.46859531433;42884;42911;43578.564214358084;43949.340759888626;44378.77810610926;37062.62937370592;37394.25211495755;38471.615283847364;40595;41349.1730165395;7988.84022319562;7995;8144.267015968591;8204.507729536246;8423.326133909395;27891.302717432227;27971.58042629403;28284.292892677848;28884;28899.277518061375;33504;36386.8180659095;36957.445638315985;37086.44370334393;37412.25175496529;9624.326297159132;9729.902700973184;9768.413895166314;9774;9806.362586431858;11039.282446640942;11088.611898583511;11174.888251117385;11705.414729263332;11923.582674606347;10369.585216591251;10569.207309451976;10964.835527467254;11002.064824489687;11026.669199924016;9946.154576860758;10248.743781405525;10307.793844123225;10737.46312684347;10804.837927430937;10459.94770026145;10755;10970.067544258827;11017.338959662446;11203.775924481302;8962.68630597926;9024;9366.625334986524;9414;9440.716778496657;8777.561121943749;8980.775480612776;9181.908180918372;9296.674616388394;9515.286353523652 17:04:07 INFO - PROCESS | 1780 | __end_tp_report 17:04:07 INFO - PROCESS | 1780 | __start_cc_report 17:04:07 INFO - PROCESS | 1780 | _x_x_mozilla_cycle_collect,921 17:04:07 INFO - PROCESS | 1780 | __end_cc_report 17:04:07 INFO - PROCESS | 1780 | __startTimestamp1460505847835__endTimestamp 17:04:07 INFO - PROCESS | 1780 | 17:04:07 INFO - PROCESS | 1780 | ------- Summary: start ------- 17:04:07 INFO - PROCESS | 1780 | Number of tests: 6 17:04:07 INFO - PROCESS | 1780 | 17:04:07 INFO - PROCESS | 1780 | [#0] dojo.html Cycles:165 Average:4584.31 Median:4705.86 stddev:470.99 (10.0%) stddev-sans-first:446.06 17:04:07 INFO - PROCESS | 1780 | Values: 2603.5 2670.4 2679.5 2679.8 2702.0 4505.9 4574.6 4598.4 4598.5 4606.9 4606.3 4634.6 4657.4 4665.2 4702.1 4172.0 4193.7 4208.5 4251.6 4391.8 4350.4 4355.6 4363.5 4396.2 4400.3 4121.8 4208.3 4237.4 4296.1 4323.0 4245.7 4275.0 4278.2 4282.0 4320.9 4228.2 4236.4 4247.7 4247.8 4293.1 4340.7 4448.9 4476.6 4484.1 4543.5 4864.9 4892.0 4894.5 4897.0 4922.3 4898.4 4929.4 4934.4 4938.0 4980.1 4582.9 4604.2 4604.4 4653.2 4671.0 5129.1 5129.1 5147.5 5147.6 5160.4 4925.2 4939.5 4943.0 4946.8 5002.4 4857.1 4968.2 5018.2 5060.8 5066.4 4913.7 4930.2 4932.3 4934.1 4985.0 4801.0 4898.8 4901.9 4917.4 4958.0 4108.4 4118.9 4181.5 4182.5 4186.3 3634.6 3636.1 3664.6 3669.6 3671.7 4304.7 4329.8 4341.0 4363.3 4384.3 4842.3 4897.8 4955.0 4994.2 5024.2 4338.2 4342.6 4362.5 4381.4 4384.2 4430.8 4435.6 4441.9 4443.7 4490.3 4633.7 4715.3 4727.2 4757.4 4805.7 4949.4 4963.3 4963.7 5004.7 5018.1 4656.9 4701.9 4701.9 4705.3 4755.3 4773.2 4885.1 4901.4 4945.8 4962.7 4951.9 4962.7 4970.6 4972.9 5015.1 4814.2 4814.3 4815.6 4854.9 4865.8 4703.5 4767.9 4818.4 4839.1 4866.3 4725.6 4730.0 4738.0 4738.4 4776.2 4833.2 4836.9 4837.7 4839.1 4891.1 4583.8 4705.9 4788.8 4844.7 4854.7 17:04:07 INFO - PROCESS | 1780 | 17:04:07 INFO - PROCESS | 1780 | [#1] ext.html Cycles:180 Average:45153.00 Median:19458.14 stddev:89635.46 (460.7%) stddev-sans-first:89824.44 17:04:07 INFO - PROCESS | 1780 | Values: 582.3 593.9 615.3 627.4 632.4 32745.5 33430.8 33517.3 33814.7 34891.5 35349.6 36004.8 36047.3 36149.3 36176.3 7188.5 7635.5 7851.9 7859.5 9515.2 9687.1 9878.4 9880.2 9881.2 9888.1 9804.5 9897.7 9900.9 9905.1 9907.7 9814.3 9861.6 9875.1 9881.8 9896.3 9676.8 9760.5 9762.2 9764.4 10029.3 35820.6 36247.8 36296.0 36296.5 36316.0 3090.5 3117.7 3252.8 3497.8 3789.9 28120.9 28265.7 28299.3 29568.9 30139.8 3343.3 3353.1 3353.7 3448.8 3566.6 156234.0 157610.2 158905.0 159015.0 159650.0 50032.2 52817.5 52834.7 52864.2 52968.7 55526.7 55709.7 55780.0 55904.4 55910.0 12879.5 13151.8 13152.8 13157.2 13173.5 9620.6 9746.9 9752.9 9756.8 9761.3 17231.3 18165.1 18218.5 18315.6 18357.8 6684.5 6861.9 7086.7 7107.0 7227.7 855.8 902.9 918.8 1025.9 1097.8 26835.6 27565.9 28185.3 28196.2 28276.2 927.3 938.1 949.5 994.2 1065.5 14673.5 14869.3 14947.3 15022.4 15196.0 301367.0 531098.0 546526.0 547638.0 548942.0 47307.0 47991.3 48381.0 48410.3 48452.0 1090.4 1230.2 1261.8 1281.3 1286.3 25999.2 28228.2 28864.4 28937.3 29018.6 38486.6 39416.4 39449.6 39486.4 39682.0 237149.0 237473.0 238255.0 238439.0 239346.0 25070.2 25436.5 37493.3 38869.8 39507.6 35946.3 36087.8 36827.0 37136.8 40769.4 33271.3 33477.0 33834.7 33918.0 34853.8 33547.7 33796.8 33913.5 34033.0 34441.3 30437.4 34276.4 34700.8 35052.6 35236.3 23096.3 29010.9 30750.9 31082.7 31240.0 24647.0 25638.5 25771.2 25828.6 26063.5 17:04:07 INFO - PROCESS | 1780 | 17:04:07 INFO - PROCESS | 1780 | [#2] jquery.html Cycles:180 Average:25314.67 Median:401698.00 stddev:65832.27 (16.4%) stddev-sans-first:65990.31 17:04:07 INFO - PROCESS | 1780 | Values: 374.2 381.6 382.7 384.6 388.4 10364.7 10895.3 10910.8 10913.5 15474.3 17093.1 17599.1 17831.1 17999.1 18035.4 5513.6 5744.4 5749.2 5750.2 5752.1 3967.8 5472.6 6457.3 6842.3 6874.3 6470.8 6834.5 6852.3 6862.5 6863.6 6734.8 6805.2 6830.7 6832.9 6840.7 6139.0 6540.8 6582.5 6590.5 6591.3 21485.6 21533.2 22261.6 22795.1 22998.5 2026.4 2043.8 2101.5 2123.3 2163.4 13834.7 14402.6 14471.6 14527.2 14775.0 1859.9 1967.0 1977.3 1978.3 2010.0 75737.6 77379.0 77882.2 78326.0 80363.6 15905.1 15923.2 15995.8 16173.8 16939.3 29120.3 29126.9 29427.8 29485.6 29544.3 8016.7 8039.4 8173.1 8232.7 8383.5 6534.5 6584.4 6602.5 6740.8 6744.1 8280.4 8344.8 8442.9 8475.2 8476.8 2783.5 3092.8 3395.5 3419.7 3546.7 895.1 938.5 944.6 955.6 965.6 15697.4 16181.8 16193.8 16252.7 16542.1 854.2 860.5 872.7 886.3 952.3 9070.5 9161.8 9295.3 9330.2 9457.2 391998.0 398619.0 400752.0 402644.0 404574.0 73248.6 73901.6 74440.6 74663.3 76187.6 901.8 910.5 911.9 916.4 950.6 14411.6 14427.6 14525.6 14636.9 14928.9 30740.5 30746.1 31284.7 32757.3 34471.3 42266.8 42874.4 43413.6 43488.8 43986.6 6747.5 6812.3 6935.5 7179.9 7208.3 8568.1 12243.3 12279.9 12293.6 12374.1 10135.4 10416.0 10603.4 10617.8 10667.0 10514.5 10579.3 10633.0 10662.2 10897.3 10295.4 10618.9 10663.4 10671.9 10825.7 6655.1 6999.9 7122.1 7213.8 7463.6 7795.5 9563.9 10287.3 10316.8 10389.8 17:04:07 INFO - PROCESS | 1780 | 17:04:07 INFO - PROCESS | 1780 | [#3] mootools.html Cycles:180 Average:5385.31 Median:6673.28 stddev:2873.97 (43.1%) stddev-sans-first:2864.90 17:04:07 INFO - PROCESS | 1780 | Values: 1210.4 1449.9 1504.1 1670.3 1834.1 7258.6 7535.7 7545.6 7550.4 7564.2 7345.6 7473.1 7482.7 7483.8 7489.4 1902.4 2165.9 2178.9 2193.2 2256.3 2237.8 2255.7 2256.8 2261.4 2263.4 2179.5 2208.6 2222.1 2227.7 2237.7 1896.3 2190.0 2241.5 2251.9 2260.7 2138.3 2145.7 2147.8 2152.1 2230.2 7480.0 7522.6 7545.3 7557.5 7581.3 4278.5 4421.3 4436.9 4446.3 4476.7 2942.2 2957.3 3012.3 3067.2 3076.9 921.5 924.3 935.9 936.2 950.7 10478.7 10490.9 10495.4 10503.4 10512.5 4031.3 4254.4 4278.0 4429.2 4429.8 8884.8 8943.8 8948.6 8967.8 8975.1 3933.9 4436.5 4445.3 4447.4 4449.7 3681.3 3689.6 3691.8 3920.6 4125.5 3555.6 3605.4 3649.9 3659.4 3739.1 1188.4 1188.7 1204.0 1206.8 1208.3 1195.9 1212.6 1229.0 1240.2 1252.6 7178.3 7229.7 7253.3 7353.9 7359.0 428.9 437.0 437.0 440.5 454.8 5356.5 5440.9 5706.0 5782.4 5788.4 8892.4 9023.9 9375.4 9504.5 9514.6 9288.0 9368.4 9382.4 9415.2 9419.3 6938.5 7283.8 7317.3 7325.2 7334.5 7084.1 7099.4 7162.8 7168.0 7387.0 8878.2 8912.1 8957.9 8960.1 9033.9 8895.0 9018.5 9031.6 9139.2 9139.7 6215.3 6563.0 6640.3 6737.7 6873.4 7407.9 7445.4 7462.1 7469.6 7483.4 6695.2 6868.2 6884.3 6981.0 6983.3 6670.7 6675.9 6681.4 6761.5 6778.9 6965.3 7065.8 7194.1 7256.0 7263.4 6576.6 6630.8 6689.1 6690.5 6702.8 6689.4 6769.1 6776.5 6777.0 6781.7 17:04:07 INFO - PROCESS | 1780 | 17:04:07 INFO - PROCESS | 1780 | [#4] prototype.html Cycles:180 Average:4434.27 Median:5038.48 stddev:1275.39 (25.3%) stddev-sans-first:1240.46 17:04:07 INFO - PROCESS | 1780 | Values: 290.2 297.4 308.1 321.6 321.8 5021.2 5031.0 5045.2 5085.1 5101.9 5022.4 5028.7 5038.2 5038.8 5044.7 3752.0 3854.0 3866.4 3979.1 4034.8 4012.7 4013.3 4024.2 4030.9 4033.2 3740.5 3984.2 3992.6 3995.3 4005.9 3740.8 3885.9 3936.4 3947.0 3951.8 3460.2 3474.5 3476.1 3487.1 3488.8 4840.1 4843.4 4849.6 4849.8 4856.4 4302.2 4537.9 4558.6 4566.2 4583.4 5241.9 5263.2 5271.1 5282.3 5286.2 3858.8 3863.5 3863.8 3865.5 3873.6 5482.1 5537.4 5554.6 5588.1 5609.4 3970.0 3983.2 3990.3 3990.8 3991.8 4050.9 4052.7 4056.2 4056.9 4059.7 4455.9 4579.4 4582.4 4586.5 4586.8 5340.9 5360.7 5370.7 5377.0 5386.5 1400.5 1419.8 1421.6 1426.8 1427.8 903.4 933.7 971.4 985.4 991.4 4654.8 4679.8 4735.8 4741.5 4742.7 5419.9 5449.2 5482.4 5487.6 5491.5 4627.2 4683.5 4694.5 4748.1 4756.1 2912.8 2916.8 2923.1 2923.1 2929.1 5146.6 5160.4 5178.9 5182.7 5189.5 5385.4 5555.0 5581.6 5602.5 5612.1 5101.7 5134.0 5136.5 5159.2 5160.7 5418.4 5426.2 5432.6 5440.9 5485.6 5161.3 5421.9 5447.5 5449.1 5474.1 5225.6 5248.7 5248.9 5251.2 5274.7 3859.6 3881.1 3882.0 3882.8 3892.1 5279.1 5565.5 5566.5 5578.8 5586.7 5328.9 5334.9 5352.9 5370.7 5386.8 5142.5 5340.8 5353.0 5358.0 5359.0 5021.3 5293.5 5295.9 5297.5 5297.6 5152.8 5315.7 5378.8 5388.1 5389.6 5210.6 5245.8 5250.2 5256.0 5275.2 17:04:07 INFO - PROCESS | 1780 | 17:04:07 INFO - PROCESS | 1780 | [#5] yui.html Cycles:180 Average:12406.38 Median:44200.89 stddev:13861.46 (31.4%) stddev-sans-first:13872.66 17:04:07 INFO - PROCESS | 1780 | Values: 740.4 751.5 760.3 780.1 790.9 11903.6 12484.9 12509.7 12563.7 12570.8 12988.8 13027.5 13073.3 13112.7 13126.3 645.6 829.3 835.7 836.7 836.7 787.4 819.2 821.1 821.4 821.8 859.3 860.0 863.1 864.2 865.6 666.4 841.8 855.1 855.9 856.2 630.8 631.3 631.6 632.6 633.1 10893.0 10922.9 10943.6 10956.7 10960.5 12376.1 12864.9 12893.7 12926.5 12960.7 9998.5 10000.8 10044.2 10132.0 10203.7 3251.6 3292.1 3316.9 3342.0 3401.2 49853.3 50294.5 50296.2 50817.5 51100.2 9794.6 9839.4 9846.1 9864.5 10000.2 17677.1 17679.4 17702.2 17716.8 17736.4 6723.2 6799.2 6824.5 6879.2 6941.2 3927.9 3965.5 3975.1 4029.8 4052.5 2898.6 2970.8 2977.9 2997.8 2998.3 505.6 508.9 522.7 522.8 524.8 490.8 521.6 612.2 627.4 638.4 7607.2 7636.7 7933.7 8066.3 8214.3 543.0 564.1 615.7 620.6 622.8 3728.8 3795.7 3834.8 3938.4 4053.4 42519.6 43939.1 44023.0 52042.0 53140.5 42884.0 42911.0 43578.6 43949.3 44378.8 37062.6 37394.3 38471.6 40595.0 41349.2 7988.8 7995.0 8144.3 8204.5 8423.3 27891.3 27971.6 28284.3 28884.0 28899.3 33504.0 36386.8 36957.4 37086.4 37412.3 9624.3 9729.9 9768.4 9774.0 9806.4 11039.3 11088.6 11174.9 11705.4 11923.6 10369.6 10569.2 10964.8 11002.1 11026.7 9946.2 10248.7 10307.8 10737.5 10804.8 10459.9 10755.0 10970.1 11017.3 11203.8 8962.7 9024.0 9366.6 9414.0 9440.7 8777.6 8980.8 9181.9 9296.7 9515.3 17:04:07 INFO - PROCESS | 1780 | -------- Summary: end -------- 17:04:07 INFO - PROCESS | 1780 | 17:04:08 INFO - TEST-INFO | 1780: exit 0 17:04:08 INFO - TEST-OK | dromaeo_css | took 1118107ms 17:04:08 INFO - TEST-START | kraken 17:04:08 INFO - operating with platform_type : linux_ 17:04:08 INFO - Initialising browser for kraken test... 17:04:08 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnem0zW/profile http://localhost:39477/getInfo.html) 17:04:12 INFO - PROCESS | 1955 | __metrics Screen width/height:1600/1200 17:04:12 INFO - PROCESS | 1955 | colorDepth:24 17:04:12 INFO - PROCESS | 1955 | Browser inner width/height: 1024/697 17:04:12 INFO - PROCESS | 1955 | __metrics 17:04:13 ERROR - PROCESS | 1955 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:04:14 INFO - TEST-INFO | 1955: exit 0 17:04:14 INFO - Browser initialized. 17:04:14 INFO - Running cycle 1/1 for kraken test... 17:04:14 INFO - TEST-INFO | started process 2037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnem0zW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:04:26 INFO - PROCESS | 2037 | RSS: Main: 154714112 17:04:26 INFO - PROCESS | 2037 | 17:04:29 INFO - PROCESS | 2037 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39477/tests/kraken/driver.html?testName=audio-beat-detection) 17:04:30 INFO - PROCESS | 2037 | RSS: Main: 209764352 17:04:30 INFO - PROCESS | 2037 | 17:04:33 INFO - PROCESS | 2037 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39477/tests/kraken/driver.html?testName=audio-dft) 17:04:33 INFO - PROCESS | 2037 | RSS: Main: 194621440 17:04:33 INFO - PROCESS | 2037 | 17:04:36 INFO - PROCESS | 2037 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39477/tests/kraken/driver.html?testName=audio-fft) 17:04:37 INFO - PROCESS | 2037 | RSS: Main: 266342400 17:04:37 INFO - PROCESS | 2037 | 17:04:39 INFO - PROCESS | 2037 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39477/tests/kraken/driver.html?testName=audio-oscillator) 17:04:40 INFO - PROCESS | 2037 | RSS: Main: 174686208 17:04:40 INFO - PROCESS | 2037 | 17:04:42 INFO - PROCESS | 2037 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39477/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:04:43 INFO - PROCESS | 2037 | RSS: Main: 178462720 17:04:43 INFO - PROCESS | 2037 | 17:04:46 INFO - PROCESS | 2037 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39477/tests/kraken/driver.html?testName=imaging-darkroom) 17:04:46 INFO - PROCESS | 2037 | RSS: Main: 214605824 17:04:46 INFO - PROCESS | 2037 | 17:04:50 INFO - PROCESS | 2037 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39477/tests/kraken/driver.html?testName=imaging-desaturate) 17:04:50 INFO - PROCESS | 2037 | RSS: Main: 213393408 17:04:50 INFO - PROCESS | 2037 | 17:04:53 INFO - PROCESS | 2037 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39477/tests/kraken/driver.html?testName=json-parse-financial) 17:04:54 INFO - PROCESS | 2037 | RSS: Main: 214138880 17:04:54 INFO - PROCESS | 2037 | 17:04:56 INFO - PROCESS | 2037 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39477/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:04:56 INFO - PROCESS | 2037 | RSS: Main: 201449472 17:04:56 INFO - PROCESS | 2037 | 17:04:58 INFO - PROCESS | 2037 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39477/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:04:59 INFO - PROCESS | 2037 | RSS: Main: 205176832 17:04:59 INFO - PROCESS | 2037 | 17:05:01 INFO - PROCESS | 2037 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39477/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:05:01 INFO - PROCESS | 2037 | RSS: Main: 218382336 17:05:01 INFO - PROCESS | 2037 | 17:05:04 INFO - PROCESS | 2037 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:05:05 INFO - PROCESS | 2037 | RSS: Main: 223371264 17:05:05 INFO - PROCESS | 2037 | 17:05:08 INFO - PROCESS | 2037 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:05:08 INFO - PROCESS | 2037 | RSS: Main: 219197440 17:05:08 INFO - PROCESS | 2037 | 17:05:10 INFO - PROCESS | 2037 | Cycle 1(1): loaded http://localhost:39477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39477/tests/kraken/driver.html?testName=ai-astar) 17:05:10 INFO - PROCESS | 2037 | RSS: Main: 281690112 17:05:10 INFO - PROCESS | 2037 | 17:05:10 INFO - PROCESS | 2037 | __start_tp_report 17:05:10 INFO - PROCESS | 2037 | _x_x_mozilla_page_load 17:05:10 INFO - PROCESS | 2037 | _x_x_mozilla_page_load_details 17:05:10 INFO - PROCESS | 2037 | |i|pagename|runs| 17:05:10 INFO - PROCESS | 2037 | |0;ai-astar;112;113;108;114;114;114;102;114;115;114 17:05:10 INFO - PROCESS | 2037 | |1;audio-beat-detection;158;131;158;180;140;169;166;132;188;132 17:05:10 INFO - PROCESS | 2037 | |2;audio-dft;162;159;162;160;161;162;162;162;161;163 17:05:10 INFO - PROCESS | 2037 | |3;audio-fft;75;77;117;107;74;73;76;116;102;74 17:05:10 INFO - PROCESS | 2037 | |4;audio-oscillator;94;94;148;94;94;94;146;95;94;140 17:05:10 INFO - PROCESS | 2037 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;117;117;118 17:05:10 INFO - PROCESS | 2037 | |6;imaging-darkroom;146;146;146;146;145;146;146;146;145;145 17:05:10 INFO - PROCESS | 2037 | |7;imaging-desaturate;95;95;95;95;96;95;96;95;96;95 17:05:10 INFO - PROCESS | 2037 | |8;json-parse-financial;63;63;64;63;64;63;63;82;62;60 17:05:10 INFO - PROCESS | 2037 | |9;json-stringify-tinderbox;64;64;64;64;65;64;63;65;64;67 17:05:10 INFO - PROCESS | 2037 | |10;stanford-crypto-aes;83;83;82;82;84;84;93;84;84;84 17:05:10 INFO - PROCESS | 2037 | |11;stanford-crypto-ccm;140;137;135;136;134;135;136;144;187;139 17:05:10 INFO - PROCESS | 2037 | |12;stanford-crypto-pbkdf2;180;170;175;175;170;169;167;168;170;169 17:05:10 INFO - PROCESS | 2037 | |13;stanford-crypto-sha256-iterative;72;70;72;71;73;71;74;76;72;73 17:05:10 INFO - PROCESS | 2037 | __end_tp_report 17:05:10 INFO - PROCESS | 2037 | __start_cc_report 17:05:10 INFO - PROCESS | 2037 | _x_x_mozilla_cycle_collect,1875 17:05:10 INFO - PROCESS | 2037 | __end_cc_report 17:05:10 INFO - PROCESS | 2037 | __startTimestamp1460505910934__endTimestamp 17:05:10 INFO - PROCESS | 2037 | 17:05:10 INFO - PROCESS | 2037 | ------- Summary: start ------- 17:05:10 INFO - PROCESS | 2037 | Number of tests: 14 17:05:10 INFO - PROCESS | 2037 | 17:05:10 INFO - PROCESS | 2037 | [#0] ai-astar Cycles:10 Average:112.00 Median:114.00 stddev:4.03 (3.5%) stddev-sans-first:4.27 17:05:10 INFO - PROCESS | 2037 | Values: 112.0 113.0 108.0 114.0 114.0 114.0 102.0 114.0 115.0 114.0 17:05:10 INFO - PROCESS | 2037 | 17:05:10 INFO - PROCESS | 2037 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:162.00 stddev:20.83 (12.9%) stddev-sans-first:22.08 17:05:10 INFO - PROCESS | 2037 | Values: 158.0 131.0 158.0 180.0 140.0 169.0 166.0 132.0 188.0 132.0 17:05:10 INFO - PROCESS | 2037 | 17:05:10 INFO - PROCESS | 2037 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 17:05:10 INFO - PROCESS | 2037 | Values: 162.0 159.0 162.0 160.0 161.0 162.0 162.0 162.0 161.0 163.0 17:05:10 INFO - PROCESS | 2037 | 17:05:10 INFO - PROCESS | 2037 | [#3] audio-fft Cycles:10 Average:89.10 Median:74.00 stddev:18.92 (25.6%) stddev-sans-first:19.36 17:05:10 INFO - PROCESS | 2037 | Values: 75.0 77.0 117.0 107.0 74.0 73.0 76.0 116.0 102.0 74.0 17:05:10 INFO - PROCESS | 2037 | 17:05:10 INFO - PROCESS | 2037 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:94.00 stddev:24.49 (26.0%) stddev-sans-first:25.34 17:05:10 INFO - PROCESS | 2037 | Values: 94.0 94.0 148.0 94.0 94.0 94.0 146.0 95.0 94.0 140.0 17:05:10 INFO - PROCESS | 2037 | 17:05:10 INFO - PROCESS | 2037 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:05:10 INFO - PROCESS | 2037 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 118.0 17:05:10 INFO - PROCESS | 2037 | 17:05:10 INFO - PROCESS | 2037 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 17:05:10 INFO - PROCESS | 2037 | Values: 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 17:05:10 INFO - PROCESS | 2037 | 17:05:10 INFO - PROCESS | 2037 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:05:10 INFO - PROCESS | 2037 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 17:05:10 INFO - PROCESS | 2037 | 17:05:10 INFO - PROCESS | 2037 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:63.00 stddev:6.18 (9.8%) stddev-sans-first:6.53 17:05:10 INFO - PROCESS | 2037 | Values: 63.0 63.0 64.0 63.0 64.0 63.0 63.0 82.0 62.0 60.0 17:05:10 INFO - PROCESS | 2037 | 17:05:10 INFO - PROCESS | 2037 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.00 stddev:1.07 (1.7%) stddev-sans-first:1.13 17:05:10 INFO - PROCESS | 2037 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 63.0 65.0 64.0 67.0 17:05:10 INFO - PROCESS | 2037 | 17:05:10 INFO - PROCESS | 2037 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.00 stddev:3.16 (3.8%) stddev-sans-first:3.32 17:05:10 INFO - PROCESS | 2037 | Values: 83.0 83.0 82.0 82.0 84.0 84.0 93.0 84.0 84.0 84.0 17:05:10 INFO - PROCESS | 2037 | 17:05:10 INFO - PROCESS | 2037 | [#11] stanford-crypto-ccm Cycles:10 Average:142.30 Median:138.00 stddev:15.99 (11.6%) stddev-sans-first:16.93 17:05:10 INFO - PROCESS | 2037 | Values: 140.0 137.0 135.0 136.0 134.0 135.0 136.0 144.0 187.0 139.0 17:05:10 INFO - PROCESS | 2037 | 17:05:10 INFO - PROCESS | 2037 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:170.00 stddev:4.06 (2.4%) stddev-sans-first:2.83 17:05:10 INFO - PROCESS | 2037 | Values: 180.0 170.0 175.0 175.0 170.0 169.0 167.0 168.0 170.0 169.0 17:05:10 INFO - PROCESS | 2037 | 17:05:10 INFO - PROCESS | 2037 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:72.50 stddev:1.71 (2.4%) stddev-sans-first:1.81 17:05:10 INFO - PROCESS | 2037 | Values: 72.0 70.0 72.0 71.0 73.0 71.0 74.0 76.0 72.0 73.0 17:05:10 INFO - PROCESS | 2037 | -------- Summary: end -------- 17:05:10 INFO - PROCESS | 2037 | 17:05:11 INFO - TEST-INFO | 2037: exit 0 17:05:11 INFO - TEST-OK | kraken | took 63396ms 17:05:11 INFO - SUITE-END | took 1181s 17:05:12 INFO - Completed test suite (00:19:41) 17:05:12 INFO - javascript benchmark 17:05:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2603.492318997796, 2670.3724624713177, 2679.5176868163735, 2679.825811322263, 2702.0137649757844, 4505.932411013838, 4574.5882870541645, 4598.448186217654, 4598.494165641777, 4606.930896036562, 4606.262997920333, 4634.629229661619, 4657.441107067149, 4665.206914824479, 4702.0595880823885, 4171.979140104295, 4193.685473589493, 4208.494980602332, 4251.574842515754, 4391.758453285068, 4350.390945267649, 4355.629771469429, 4363.541828108035, 4396.20868243716, 4400.251957167289, 4121.835126594932, 4208.263553878059, 4237.364395340693, 4296.140771845612, 4323.0, 4245.745255284662, 4275.0167461483725, 4278.165757677254, 4281.978590107061, 4320.870373888757, 4228.238916994939, 4236.449261596003, 4247.660187185018, 4247.830086796555, 4293.055527783882, 4340.65274778017, 4448.872835969611, 4476.597106260452, 4484.148011877765, 4543.5456454354635, 4864.878378040542, 4891.972685736, 4894.535019173173, 4897.020595880838, 4922.310876477296, 4898.412190537123, 4929.433115191763, 4934.407871055496, 4937.950620493785, 4980.05378977993, 4582.88542786433, 4604.217283061854, 4604.355390245369, 4653.185692503798, 4671.0, 5129.076766182048, 5129.102407078746, 5147.510986456281, 5147.613928955343, 5160.354955630546, 4925.187344088257, 4939.506049395031, 4942.986687729007, 4946.826861059918, 5002.399712034579, 4857.101436234308, 4968.22992436173, 5018.222175562793, 5060.7722652480725, 5066.417362003417, 4913.656044076952, 4930.161872481687, 4932.260160975882, 4934.1118598651865, 4984.950150498448, 4800.95199048012, 4898.804047838118, 4901.926471102936, 4917.385326834145, 4958.033183529177, 4108.4453598764385, 4118.876433706993, 4181.477315335583, 4182.519010313792, 4186.28833098374, 3634.5638523376833, 3636.090977255686, 3664.578573464086, 3669.5963444021136, 3671.6695497405362, 4304.720193187432, 4329.848455304049, 4340.956590434118, 4363.323684828857, 4384.320430333303, 4842.322074909515, 4897.7795999180125, 4954.950450495449, 4994.150994330972, 5024.221245706921, 4338.219120558267, 4342.5874541918465, 4362.498312694017, 4381.364702118175, 4384.232759267115, 4430.800613972379, 4435.578620031092, 4441.888952776207, 4443.666724995638, 4490.281554951192, 4633.72197668141, 4715.316279139574, 4727.17274476972, 4757.35775670287, 4805.735684537384, 4949.381327334083, 4963.305137280856, 4963.677360971526, 5004.724740139327, 5018.071656743514, 4656.906861862812, 4701.905961880811, 4701.905961880811, 4705.317728929354, 4755.286706993978, 4773.188557945088, 4885.071836351082, 4901.387326584177, 4945.7527123644395, 4962.6774259673, 4951.876203094951, 4962.6774259673, 4970.577500912463, 4972.8756781080765, 5015.072211640858, 4814.20565606685, 4814.325994360723, 4815.590674792542, 4854.878628034327, 4865.781039853286, 4703.459102203154, 4767.928481072856, 4818.4217893852965, 4839.056384005085, 4866.318715379921, 4725.645576581839, 4729.976350118227, 4737.976310118427, 4738.431388233434, 4776.21192503233, 4833.202521583899, 4836.879078023077, 4837.7097374157665, 4839.104765618372, 4891.095147397743, 4583.793729282123, 4705.858824235278, 4788.808447662054, 4844.733539655353, 4854.660173787801], "value": 4555.300382070318, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.2634367525081, 593.8841925824463, 615.2739767074853, 627.3600927054407, 632.4181752787435, 32745.50881736773, 33430.832845835735, 33517.329653406916, 33814.66185338146, 34891.47662785057, 35349.646503534954, 36004.819975900085, 36047.27905441896, 36149.277014459694, 36176.2764744705, 7188.460865435087, 7635.503692260013, 7851.882221766649, 7859.489133206352, 9515.19120874723, 9687.079727425884, 9878.407295562254, 9880.160186384166, 9881.160101391355, 9888.060634239771, 9804.509774511282, 9897.703068907907, 9900.90099099007, 9905.059019393182, 9907.653232136876, 9814.312998090136, 9861.556229969668, 9875.061869122494, 9881.802363952716, 9896.25778066648, 9676.806463870684, 9760.511974401252, 9762.170215531689, 9764.365316254421, 10029.297949143564, 35820.64179358199, 36247.81876090629, 36296.0, 36296.45555316672, 36316.0, 3090.536419537065, 3117.688231176887, 3252.788568743024, 3497.7726447780815, 3789.8673546426016, 28120.85939570289, 28265.717342826516, 28299.292517687016, 29568.8521557393, 30139.849300753354, 3343.3480471308103, 3353.144948038259, 3353.748468864845, 3448.793072415638, 3566.6433356664384, 156234.0, 157610.21194894068, 158905.0, 159015.0, 159650.0, 50032.24951625729, 52817.471825282024, 52834.73582632062, 52864.20703689448, 52968.73515632397, 55526.72236638791, 55709.721451392485, 55780.0, 55904.440955589926, 55910.0, 12879.484820607258, 13151.802722959163, 13152.802707959388, 13157.210567365797, 13173.538926137539, 9620.567074481665, 9746.902530974741, 9752.902470975341, 9756.756081098029, 9761.267904907161, 17231.310747569958, 18165.091745412676, 18218.54453638643, 18315.633687326444, 18357.816421835876, 6684.465242780566, 6861.897071543831, 7086.681099350541, 7107.0, 7227.710891564278, 855.8159995600976, 902.9345372460559, 918.8300164469595, 1025.8922813104666, 1097.8133717268083, 26835.597466038023, 27565.86217068942, 28185.295367615563, 28196.154115376572, 28276.15171544857, 927.2720914082413, 938.0525669074284, 949.4872768704822, 994.2344394815951, 1065.5098654618807, 14673.486427974969, 14869.256537173314, 14947.252637368088, 15022.399104035934, 15196.0, 301367.0, 531098.0, 546526.0, 547638.0, 548942.0, 47307.0, 47991.28013079806, 48381.0, 48410.27384589234, 48452.0, 1090.4166271044794, 1230.1511956749814, 1261.8107283907486, 1281.3401098434315, 1286.2539726958341, 25999.220023399328, 28228.15315540537, 28864.42271154523, 28937.276568085967, 29018.564721529616, 38486.6151338483, 39416.40875386814, 39449.60550394459, 39486.40770388504, 39682.0, 237149.0, 237473.0, 238255.0, 238439.0, 239346.0, 25070.247892563253, 25436.49127017486, 37493.250134997696, 38869.80565097156, 39507.60492395039, 35946.28107437889, 36087.819560902026, 36827.0, 37136.81431592825, 40769.38845917373, 33271.33457330888, 33477.0, 33834.66165338315, 33918.0, 34853.82573087118, 33547.664523354455, 33796.831015844764, 33913.49129763105, 34033.0, 34441.311173776885, 30437.391252174388, 34276.36445581016, 34700.82649586736, 35052.64947350494, 35236.29527409489, 23096.307110786704, 29010.854945725136, 30750.862034798745, 31082.689173108884, 31240.0, 24647.0, 25638.487230255665, 25771.226863194133, 25828.613592852464, 26063.478730425664], "value": 17479.65125034561, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.1656106881653, 381.6450700848211, 382.7167895757141, 384.64036126221987, 388.42513080640634, 10364.740881477957, 10895.346279223233, 10910.836337454944, 10913.454327283644, 15474.303656335464, 17093.145342732874, 17599.120043997813, 17831.108444577752, 17999.100044997762, 18035.36876209333, 5513.558915286778, 5744.425557444243, 5749.195112684228, 5750.223719797837, 5752.1084231943905, 3967.7817720025387, 5472.644278121929, 6457.257415397243, 6842.315768423167, 6874.312568743136, 6470.773522926698, 6834.453243740489, 6852.28051054637, 6862.451003919699, 6863.553868998524, 6734.764283250087, 6805.183377994623, 6830.726770929157, 6832.897506537406, 6840.692168852389, 6138.9693051534905, 6540.803775886731, 6582.506312026617, 6590.538662293641, 6591.274959754423, 21485.570288594296, 21533.24633637815, 22261.554768904694, 22795.062419694346, 22998.54002919932, 2026.3515674984012, 2043.7751847296934, 2101.516651170224, 2123.341764053133, 2163.383435720812, 13834.723305533933, 14402.567922962224, 14471.638209044753, 14527.20100394478, 14775.0, 1859.9349022784272, 1966.980330196694, 1977.2782934228903, 1978.3471454420007, 2009.9698504522444, 75737.62131189364, 77379.0, 77882.22117778863, 78326.0, 80363.5981820093, 15905.115107410333, 15923.203839807964, 15995.840041599668, 16173.838261617233, 16939.306069392962, 29120.27199320034, 29126.85436572846, 29427.762946075916, 29485.557716634266, 29544.261393465335, 8016.679332826621, 8039.397045221632, 8173.100958894517, 8232.711855085043, 8383.496990180609, 6534.509911756542, 6584.407403333723, 6602.471802255808, 6740.83147921296, 6744.12326397575, 8280.420370574002, 8344.791380215544, 8442.873356899652, 8475.152484751476, 8476.770868224074, 2783.5268004439295, 3092.8400205325397, 3395.4567269236804, 3419.7435192360176, 3546.6985306249258, 895.1496078725237, 938.4603852784676, 944.5654998700675, 955.5986485675894, 965.6089283840056, 15697.372105115668, 16181.838181618034, 16193.838061619233, 16252.674946501003, 16542.0901850397, 854.1671869926772, 860.5181098584812, 872.7425409504211, 886.3347625853673, 952.33812500313, 9070.478245235496, 9161.770955726028, 9295.349325547148, 9330.160285574331, 9457.243420526342, 391998.0, 398619.0, 400752.0, 402644.0, 404574.0, 73248.63375683088, 73901.6304918472, 74440.62779686175, 74663.25336746563, 76187.61906190544, 901.7835719427421, 910.4537277633367, 911.8723378726984, 916.4180745226829, 950.5674917912471, 14411.639709007359, 14427.639309017359, 14525.636859078608, 14636.853631463975, 14928.850711492745, 30740.538891917087, 30746.077617671504, 31284.687153128176, 32757.344853102328, 34471.31057378888, 42266.788666056476, 42874.356884646135, 43413.565864340955, 43488.78255608702, 43986.56013439825, 6747.527673063035, 6812.318768123148, 6935.549189302679, 7179.928200718135, 7208.27917208275, 8568.143469366394, 12243.326617035793, 12279.938600306941, 12293.631191064282, 12374.13381063317, 10135.442550659785, 10416.0, 10603.363798172135, 10617.840732388866, 10667.0, 10514.474276286002, 10579.31234469757, 10633.0, 10662.200334975063, 10897.29167604135, 10295.382277063101, 10618.893811061791, 10663.4135122569, 10671.94664026675, 10825.67522974312, 6655.101561289358, 6999.930000700131, 7122.145342558719, 7213.783586492414, 7463.626818659154, 7795.454318197899, 9563.904360956301, 10287.331323463952, 10316.845247321146, 10389.792204156025], "value": 9036.975376639506, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1210.3827048205412, 1449.9130052196865, 1504.1276059885265, 1670.3235189748157, 1834.0646270402099, 7258.600776957265, 7535.660895259713, 7545.584992825399, 7550.395968322535, 7564.205758395372, 7345.559266444017, 7473.103227612694, 7482.738104166356, 7483.812904677386, 7489.363404110657, 1902.4197619725978, 2165.9133634654636, 2178.8692678439265, 2193.1775584155944, 2256.345659758668, 2237.776222377757, 2255.7293124825046, 2256.808171305441, 2261.4459457432868, 2263.4228271790753, 2179.542296117809, 2208.63557513011, 2222.100049479963, 2227.7438094619083, 2237.742659594151, 1896.3078476356168, 2190.0473294117032, 2241.529278851443, 2251.921182758612, 2260.7400148982915, 2138.3050508584774, 2145.731783527059, 2147.7744836792067, 2152.1068756466047, 2230.1971290335628, 7480.027596412431, 7522.623868806538, 7545.283198096172, 7557.47097703161, 7581.3176814087, 4278.529361770203, 4421.292593185107, 4436.911261774746, 4446.266366049598, 4476.7090139140855, 2942.2497263197747, 2957.2902503399027, 3012.322227498795, 3067.1718635968164, 3076.9230769230726, 921.5438358012759, 924.2790623313826, 935.948522831244, 936.2276122199213, 950.7100334398006, 10478.685639430829, 10490.947545262301, 10495.42275174865, 10503.422311772849, 10512.526936287886, 4031.274370613318, 4254.3831144483875, 4278.0, 4429.224885645, 4429.7785110744335, 8884.777880552909, 8943.776405589782, 8948.552572371356, 8967.820643587222, 8975.057618949917, 3933.8623148189677, 4436.511983681857, 4445.2887537993765, 4447.355133505624, 4449.7330160190495, 3681.2821499807815, 3689.6310368963427, 3691.796951167658, 3920.6471417572557, 4125.463689720317, 3555.6444355564236, 3605.3690604144695, 3649.872254471081, 3659.4144936809985, 3739.08392443853, 1188.3701638131804, 1188.7028242939266, 1204.00669447706, 1206.843110395643, 1208.3173007250875, 1195.9222650527688, 1212.5513559982862, 1228.975420491585, 1240.1566934484456, 1252.599168266146, 7178.282171782885, 7229.710811567584, 7253.27467253281, 7353.889691654629, 7359.043324367905, 428.88420126565654, 436.975966321849, 437.0297938576355, 440.47583375782716, 454.8408057180027, 5356.544693701001, 5440.891182176334, 5706.0, 5782.421757824184, 5788.392218816964, 8892.377533572717, 9023.864642030374, 9375.437473751597, 9504.477253750973, 9514.619415223313, 9288.0, 9368.4378937264, 9382.390144640576, 9415.246780257563, 9419.293552983554, 6938.479614028867, 7283.817904552323, 7317.341439270491, 7325.2308507607, 7334.523255988237, 7084.079069720903, 7099.396551293198, 7162.785116446515, 7168.0, 7386.96306518464, 8878.156575125353, 8912.064233255414, 8957.865632015395, 8960.118375141294, 9033.909660903308, 8895.0, 9018.503982281038, 9031.645253212071, 9139.177474027369, 9139.680111196076, 6215.316315205233, 6562.967185164043, 6640.335966403321, 6737.69680364375, 6873.4157596602845, 7407.888881666671, 7445.404367650467, 7462.067241594801, 7469.58917259556, 7483.363914067365, 6695.196576410862, 6868.244493105654, 6884.345987131214, 6980.965095174694, 6983.266756990442, 6670.666466676744, 6675.899861501985, 6681.432078273207, 6761.459083273425, 6778.93221067783, 6965.268646792014, 7065.752698655522, 7194.136703595602, 7255.963720181366, 7263.418926485762, 6576.605403675795, 6630.7679231226675, 6689.09697190873, 6690.464762818866, 6702.765403210864, 6689.431398331002, 6769.052332673331, 6776.491763117688, 6777.0, 6781.728730850711], "value": 4309.603633073242, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.2193100559495, 297.41706255738757, 308.06348699952133, 321.5723088292571, 321.8342553584903, 5021.196608542629, 5030.974845125774, 5045.167547354687, 5085.135526960416, 5101.872453188672, 5022.372203474566, 5028.698278103317, 5038.168702164147, 5038.798448062083, 5044.747762611873, 3752.043228976614, 3854.0, 3866.420036994445, 3979.1444839359533, 4034.8184331704997, 4012.678985681153, 4013.2976729072443, 4024.1750441159493, 4030.9395359069636, 4033.1933613277315, 3740.45763364312, 3984.242993831163, 3992.6207010334115, 3995.3008223560905, 4005.9198816023663, 3740.775553466787, 3885.941710874339, 3936.389859571771, 3947.0, 3951.8419263229434, 3460.197240235417, 3474.5309383233193, 3476.1309672581856, 3487.128217945514, 3488.843002064888, 4840.128776820171, 4843.370361852972, 4849.612031037508, 4849.806007759686, 4856.39295088114, 4302.204092242945, 4537.914218331533, 4558.61251793598, 4566.246569316058, 4583.449986001668, 5241.947580524184, 5263.210518422229, 5271.130263506555, 5282.260483532308, 5286.233496143038, 3858.82635281413, 3863.5363756349416, 3863.8454461821493, 3865.5168103987003, 3873.624863173561, 5482.068048431776, 5537.363203231599, 5554.611177217556, 5588.1059030555325, 5609.411011843779, 3969.980150099289, 3983.203359328088, 3990.2817492851564, 3990.8204130814183, 3991.7804520751056, 4050.8987275317763, 4052.7163098582814, 4056.1684854604737, 4056.8985775355854, 4059.715819892638, 4455.910881782346, 4579.427571553556, 4582.381378513925, 4586.518415566385, 4586.839460618862, 5340.946590534123, 5360.70516121617, 5370.657335666084, 5377.0, 5386.48828361305, 1400.5168216965335, 1419.7799341102145, 1421.5664222412056, 1426.8287805463203, 1427.8215223097113, 903.408267584733, 933.705882646964, 971.4220039076879, 985.3644399362371, 991.3902949686036, 4654.790534425959, 4679.836205732783, 4735.8342458014495, 4741.478437371887, 4742.691725037862, 5419.918701219485, 5449.209864569615, 5482.369527504308, 5487.5609951203805, 5491.505764481216, 4627.177421772716, 4683.531646835289, 4694.483606803249, 4748.0978614063215, 4756.096341695136, 2912.8252304861776, 2916.7958242923214, 2923.0500087471232, 2923.064619321839, 2929.091981485746, 5146.562542183881, 5160.40655324635, 5178.8964220716125, 5182.689038657692, 5189.506996835295, 5385.407605163429, 5555.0, 5581.609287349927, 5602.495775380154, 5612.074007788669, 5101.719405432663, 5134.0, 5136.4606716295, 5159.207982133129, 5160.690358578498, 5418.403975562606, 5426.240326354393, 5432.619716619957, 5440.918386224131, 5485.6434331768305, 5161.3032240647035, 5421.864453388697, 5447.4824891635235, 5449.128139497661, 5474.124140137559, 5225.5558277545315, 5248.685078895279, 5248.947510524846, 5251.162093267326, 5274.7098909560345, 3859.5561510425537, 3881.146147847582, 3881.971277611379, 3882.8446862125197, 3892.124272038882, 5279.128943724396, 5565.471280228372, 5566.471185237558, 5578.776848925998, 5586.664800112007, 5328.946710533, 5334.893302133858, 5352.919706204488, 5370.731463426735, 5386.8383948481605, 5142.485751424828, 5340.786368545215, 5352.9732351338, 5358.035553600389, 5358.97320513395, 5021.271915572294, 5293.497117773805, 5295.9470405297, 5297.470252974672, 5297.602679798953, 5152.819651312186, 5315.681059136309, 5378.811741589026, 5388.137897936312, 5389.622726409114, 5210.609204309616, 5245.816396426107, 5250.238715386171, 5255.973720131375, 5275.235090911719], "value": 4031.281815633495, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.3706849178197, 751.4927423988806, 760.3157158557301, 780.1067777394883, 790.9011373578304, 11903.58337458189, 12484.875151248485, 12509.749805003894, 12563.748725025494, 12570.811437828439, 12988.805167922465, 13027.544035958743, 13073.346332683375, 13112.73774524509, 13126.343682815845, 645.6352161029004, 829.3116713128104, 835.7409203147014, 836.6820608168887, 836.6820608168887, 787.4291138924262, 819.1930948016229, 821.0557858462786, 821.4332110843528, 821.8109834738013, 859.299670768325, 859.9914000860006, 863.0592654007131, 864.2135656552539, 865.6018231613465, 666.4235436347573, 841.7979684875647, 855.102142750113, 855.8972923249188, 856.1994535109661, 630.8044506203091, 631.2677294338545, 631.567376347199, 632.6267502173694, 633.1168020611221, 10893.0, 10922.945385273102, 10943.56225750969, 10956.726081847937, 10960.451977401177, 12376.13367064306, 12864.871351286462, 12893.742125157538, 12926.482940682361, 12960.740785184244, 9998.45008524531, 10000.799984000352, 10044.246681498917, 10132.0, 10203.693889183336, 3251.5772949516413, 3292.061762397729, 3316.8673253069846, 3342.0141058387835, 3401.234722187513, 49853.25220121701, 50294.497055029715, 50296.24555631705, 50817.49182508165, 51100.23349649758, 9794.608215671293, 9839.360441571274, 9846.113849753414, 9864.457454840052, 10000.249981251436, 17677.11614419274, 17679.38122165718, 17702.203400846993, 17716.82283177152, 17736.379226727004, 6723.226828914738, 6799.218089919624, 6824.488163387766, 6879.2432832388395, 6941.236463988957, 3927.9214415711526, 3965.464662270614, 3975.0857302820514, 4029.81865816039, 4052.4731784867777, 2898.6086878271585, 2970.762339012874, 2977.865996030184, 2997.80514266572, 2998.250437390652, 505.6081536809003, 508.8651507350555, 522.7177324244865, 522.7621432248318, 524.7507433968834, 490.77914938277917, 521.59315733727, 612.1705089603612, 627.4290395739946, 638.3999040901538, 7607.16321204667, 7636.69453221876, 7933.682652693828, 8066.274035336848, 8214.26071653554, 542.9801139760086, 564.1087082409782, 615.7106160104744, 620.6493331267819, 622.8256088295194, 3728.832202550892, 3795.658390744791, 3834.846606135779, 3938.3895496198134, 4053.432519447221, 42519.57480425156, 43939.12121757611, 44023.0, 52042.0, 53140.46859531433, 42884.0, 42911.0, 43578.564214358084, 43949.340759888626, 44378.77810610926, 37062.62937370592, 37394.25211495755, 38471.615283847364, 40595.0, 41349.1730165395, 7988.84022319562, 7995.0, 8144.267015968591, 8204.507729536246, 8423.326133909395, 27891.302717432227, 27971.58042629403, 28284.292892677848, 28884.0, 28899.277518061375, 33504.0, 36386.8180659095, 36957.445638315985, 37086.44370334393, 37412.25175496529, 9624.326297159132, 9729.902700973184, 9768.413895166314, 9774.0, 9806.362586431858, 11039.282446640942, 11088.611898583511, 11174.888251117385, 11705.414729263332, 11923.582674606347, 10369.585216591251, 10569.207309451976, 10964.835527467254, 11002.064824489687, 11026.669199924016, 9946.154576860758, 10248.743781405525, 10307.793844123225, 10737.46312684347, 10804.837927430937, 10459.94770026145, 10755.0, 10970.067544258827, 11017.338959662446, 11203.775924481302, 8962.68630597926, 9024.0, 9366.625334986524, 9414.0, 9440.716778496657, 8777.561121943749, 8980.775480612776, 9181.908180918372, 9296.674616388394, 9515.286353523652], "value": 5881.290207772811, "unit": "score"}], "name": "dromaeo_css", "value": 6472.6033751163395, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 108.0, 114.0, 114.0, 114.0, 102.0, 114.0, 115.0, 114.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 158.0, 180.0, 140.0, 169.0, 166.0, 132.0, 188.0, 132.0], "value": 155.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 162.0, 160.0, 161.0, 162.0, 162.0, 162.0, 161.0, 163.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 117.0, 107.0, 74.0, 73.0, 76.0, 116.0, 102.0, 74.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 148.0, 94.0, 94.0, 94.0, 146.0, 95.0, 94.0, 140.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 64.0, 63.0, 63.0, 82.0, 62.0, 60.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 63.0, 65.0, 64.0, 67.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 82.0, 84.0, 84.0, 93.0, 84.0, 84.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 137.0, 135.0, 136.0, 134.0, 135.0, 136.0, 144.0, 187.0, 139.0], "value": 142.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 170.0, 175.0, 175.0, 170.0, 169.0, 167.0, 168.0, 170.0, 169.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 72.0, 71.0, 73.0, 71.0, 74.0, 76.0, 72.0, 73.0], "value": 72.4, "unit": "score"}], "name": "kraken", "value": 1584.5, "alertThreshold": 2.0}]} 17:05:12 INFO - Return code: 0 17:05:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:05:12 ERROR - # TBPL SUCCESS # 17:05:12 INFO - Running post-action listener: _resource_record_post_action 17:05:12 INFO - Running post-run listener: _resource_record_post_run 17:05:13 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 519155712; Read time: 216; Write time: 484260 17:05:13 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 233656320; Read time: 216; Write time: 260320 17:05:13 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 285499392; Read time: 0; Write time: 223940 17:05:13 INFO - Running post-run listener: _upload_blobber_files 17:05:13 INFO - Blob upload gear active. 17:05:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:05: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:05: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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:05: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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:05:13 INFO - (blobuploader) - INFO - Open directory for files ... 17:05:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:05:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:05:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:14 INFO - (blobuploader) - INFO - Done attempting. 17:05:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:05:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:05:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:15 INFO - (blobuploader) - INFO - Done attempting. 17:05:15 INFO - (blobuploader) - INFO - Iteration through files over. 17:05:15 INFO - Return code: 0 17:05:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:05:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:05:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e115ebd259eb384bd64decc71b08578f66ffba88d0704038458283cd5178e3765803ea9f0a8011170a462d378bcddb4213004a01259fb40bb46e5304fe4c9531", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/209710225955cf60da2752a776a1db2a8764b841d8c39a0a447b090a32461ce2ad115ebea46e5174ab052726b960f351daee78cf0e015fbb4b9810e7f9afe081"} 17:05:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:05:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:05:15 INFO - Contents: 17:05:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e115ebd259eb384bd64decc71b08578f66ffba88d0704038458283cd5178e3765803ea9f0a8011170a462d378bcddb4213004a01259fb40bb46e5304fe4c9531", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/209710225955cf60da2752a776a1db2a8764b841d8c39a0a447b090a32461ce2ad115ebea46e5174ab052726b960f351daee78cf0e015fbb4b9810e7f9afe081"} 17:05:15 INFO - Running post-run listener: copy_logs_to_upload_dir 17:05:15 INFO - Copying logs to upload dir... 17:05:15 INFO - mkdir: /builds/slave/test/build/upload/logs 17:05:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.107443 ========= master_lag: 38.86 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-04-12 17:05:54.518777) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 17:05:54.522640) ========= 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=41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e115ebd259eb384bd64decc71b08578f66ffba88d0704038458283cd5178e3765803ea9f0a8011170a462d378bcddb4213004a01259fb40bb46e5304fe4c9531", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/209710225955cf60da2752a776a1db2a8764b841d8c39a0a447b090a32461ce2ad115ebea46e5174ab052726b960f351daee78cf0e015fbb4b9810e7f9afe081"} build_url:https://queue.taskcluster.net/v1/task/K9Fi-2QKTs2hQI84fb1ASw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/K9Fi-2QKTs2hQI84fb1ASw/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/Firefox-Non-PGO/sha512/e115ebd259eb384bd64decc71b08578f66ffba88d0704038458283cd5178e3765803ea9f0a8011170a462d378bcddb4213004a01259fb40bb46e5304fe4c9531", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/209710225955cf60da2752a776a1db2a8764b841d8c39a0a447b090a32461ce2ad115ebea46e5174ab052726b960f351daee78cf0e015fbb4b9810e7f9afe081"}' ========= master_lag: 0.13 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 17:05:54.666173) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 17:05:54.666581) ========= 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=41bf3e9aed84707956354da8000001c5-1460504467.525809-681132510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 17:05:54.783514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 17:05:54.783877) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 17:05:54.784197) ========= ========= Total master_lag: 39.28 =========