builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-040 starttime: 1460114352.34 results: success (0) buildid: 20160408030202 builduid: b274a7f4591046aeba4f115b51f3370e revision: d9b1a9829c8ee2862955043f28183efa07de3d2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:12.337589) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:12.338058) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:12.338393) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006474 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:12.362360) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:12.362787) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:12.377317) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:12.377701) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:12.426823) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:12.427167) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:12.427592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:12.427923) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-08 04:19:12-- 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% 224M=0s 2016-04-08 04:19:12 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131741 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:12.601598) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:12.601945) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018304 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:12.656742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:12.657103) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d9b1a9829c8ee2862955043f28183efa07de3d2b --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 d9b1a9829c8ee2862955043f28183efa07de3d2b --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=9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-08 04:19:12,974 truncating revision to first 12 chars 2016-04-08 04:19:12,974 Setting DEBUG logging. 2016-04-08 04:19:12,975 attempt 1/10 2016-04-08 04:19:12,975 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d9b1a9829c8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 04:19:13,361 unpacking tar archive at: mozilla-central-d9b1a9829c8e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.688160 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:13.359099) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:13.359515) ========= echo d9b1a9829c8ee2862955043f28183efa07de3d2b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd9b1a9829c8ee2862955043f28183efa07de3d2b'] 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=9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d9b1a9829c8ee2862955043f28183efa07de3d2b program finished with exit code 0 elapsedTime=0.003735 script_repo_revision: 'd9b1a9829c8ee2862955043f28183efa07de3d2b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:13.409787) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:13.410245) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 04:19:13.420723) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-08 04:19:13.421033) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:19:13 INFO - MultiFileLogger online at 20160408 04:19:13 in /builds/slave/test 04:19:13 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 04:19:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:19:13 INFO - {'append_to_log': False, 04:19:13 INFO - 'base_work_dir': '/builds/slave/test', 04:19:13 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:19:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:19:13 INFO - 'branch': 'Firefox-Non-PGO', 04:19:13 INFO - 'buildbot_json_path': 'buildprops.json', 04:19:13 INFO - 'config_files': ('talos/linux_config.py',), 04:19:13 INFO - 'default_actions': ('clobber', 04:19:13 INFO - 'read-buildbot-config', 04:19:13 INFO - 'download-and-extract', 04:19:13 INFO - 'populate-webroot', 04:19:13 INFO - 'create-virtualenv', 04:19:13 INFO - 'install', 04:19:13 INFO - 'run-tests'), 04:19:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:19:13 INFO - 'download_minidump_stackwalk': True, 04:19:13 INFO - 'download_symbols': 'ondemand', 04:19:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:19:13 INFO - 'tooltool.py': '/tools/tooltool.py', 04:19:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:19:13 INFO - '/tools/misc-python/virtualenv.py')}, 04:19:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:19:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:19:13 INFO - 'installer_path': 'installer.exe', 04:19:13 INFO - 'log_level': 'info', 04:19:13 INFO - 'log_name': 'talos', 04:19:13 INFO - 'log_to_console': True, 04:19:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:19:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:19:13 INFO - 'opt_config_files': (), 04:19:13 INFO - 'pip_index': False, 04:19:13 INFO - 'sps_profile': False, 04:19:13 INFO - 'sps_profile_interval': 0, 04:19:13 INFO - 'suite': 'dromaeojs', 04:19:13 INFO - 'system_bits': '32', 04:19:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:19:13 INFO - 'title': 'talos-linux64-ix-040', 04:19:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:19:13 INFO - 'use_talos_json': True, 04:19:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:19:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:19:13 INFO - 'work_dir': 'build'} 04:19:13 INFO - ##### 04:19:13 INFO - ##### Running clobber step. 04:19:13 INFO - ##### 04:19:13 INFO - Running pre-action listener: _resource_record_pre_action 04:19:13 INFO - Running main action method: clobber 04:19:13 INFO - rmtree: /builds/slave/test/build 04:19:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:19:14 INFO - Running post-action listener: _resource_record_post_action 04:19:14 INFO - ##### 04:19:14 INFO - ##### Running read-buildbot-config step. 04:19:14 INFO - ##### 04:19:14 INFO - Running pre-action listener: _resource_record_pre_action 04:19:14 INFO - Running main action method: read_buildbot_config 04:19:14 INFO - Using buildbot properties: 04:19:14 INFO - { 04:19:14 INFO - "project": "", 04:19:14 INFO - "product": "firefox", 04:19:14 INFO - "script_repo_revision": "production", 04:19:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:19:14 INFO - "repository": "", 04:19:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:19:14 INFO - "buildid": "20160408030202", 04:19:14 INFO - "pgo_build": "False", 04:19:14 INFO - "basedir": "/builds/slave/test", 04:19:14 INFO - "buildnumber": 544, 04:19:14 INFO - "slavename": "talos-linux64-ix-040", 04:19:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:19:14 INFO - "platform": "ubuntu64_hw", 04:19:14 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:19:14 INFO - "branch": "mozilla-central", 04:19:14 INFO - "repo_path": "mozilla-central", 04:19:14 INFO - "revision": "d9b1a9829c8ee2862955043f28183efa07de3d2b", 04:19:14 INFO - "stage_platform": "linux64", 04:19:14 INFO - "builduid": "b274a7f4591046aeba4f115b51f3370e", 04:19:14 INFO - "slavebuilddir": "test" 04:19:14 INFO - } 04:19:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:19:14 INFO - Running post-action listener: _resource_record_post_action 04:19:14 INFO - ##### 04:19:14 INFO - ##### Running download-and-extract step. 04:19:14 INFO - ##### 04:19:14 INFO - Running pre-action listener: _resource_record_pre_action 04:19:14 INFO - Running main action method: download_and_extract 04:19:14 INFO - mkdir: /builds/slave/test/build/tests 04:19:14 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')]} 04:19:14 INFO - https://queue.taskcluster.net/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:19:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:19:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:19:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/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 04:19:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/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 04:19:16 INFO - Downloaded 1361 bytes. 04:19:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:19:16 INFO - Using the following test package requirements: 04:19:16 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:19:16 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:19:16 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:19:16 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:16 INFO - u'jsshell-linux-x86_64.zip'], 04:19:16 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:19:16 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:19:16 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:19:16 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:19:16 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:19:16 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:19:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:16 INFO - https://queue.taskcluster.net/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:19:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:19:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:19:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/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 04:19:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/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 04:19:17 INFO - Downloaded 22186012 bytes. 04:19:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:19:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:19:18 INFO - Return code: 0 04:19:18 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 04:19:18 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')]} 04:19:18 INFO - https://queue.taskcluster.net/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:19:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:19:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:19:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/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 04:19:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/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 04:19:28 INFO - Downloaded 22186012 bytes. 04:19:28 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'] 04:19:28 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 04:19:30 INFO - Return code: 0 04:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:30 INFO - https://queue.taskcluster.net/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:19:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:19:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:19:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/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 04:19:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/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 04:19:31 INFO - Downloaded 10841097 bytes. 04:19:31 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'] 04:19:31 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 04:19:31 INFO - Return code: 0 04:19: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')]} 04:19:31 INFO - https://queue.taskcluster.net/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:19:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:19:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:19:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/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 04:19:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/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 04:19:32 INFO - Downloaded 54058938 bytes. 04:19:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:19:32 INFO - mkdir: /builds/slave/test/properties 04:19:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:19:32 INFO - Writing to file /builds/slave/test/properties/build_url 04:19:32 INFO - Contents: 04:19:32 INFO - build_url:https://queue.taskcluster.net/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:19:33 INFO - Running post-action listener: _resource_record_post_action 04:19:33 INFO - Running post-action listener: set_extra_try_arguments 04:19:33 INFO - ##### 04:19:33 INFO - ##### Running populate-webroot step. 04:19:33 INFO - ##### 04:19:33 INFO - Running pre-action listener: _resource_record_pre_action 04:19:33 INFO - Running main action method: populate_webroot 04:19:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:19:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:19:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:19:33 INFO - '--tppagecycles', 04:19:33 INFO - '7'], 04:19:33 INFO - 'tests': ['tsvgm']}}, 04:19:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:19:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:19:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:19:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:19:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:19:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:19:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:33 INFO - 'talos_options': ['--disable-e10s'], 04:19:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:33 INFO - 'talos_options': ['--disable-e10s'], 04:19:33 INFO - 'tests': ['damp', 'tps']}, 04:19:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:33 INFO - 'tests': ['damp', 'tps']}, 04:19:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:19:33 INFO - 'tests': ['dromaeo_dom']}, 04:19:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:19:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:19:33 INFO - 'tests': ['a11yr', 04:19:33 INFO - 'ts_paint', 04:19:33 INFO - 'tpaint', 04:19:33 INFO - 'sessionrestore', 04:19:33 INFO - 'sessionrestore_no_auto_restore', 04:19:33 INFO - 'tabpaint']}, 04:19:33 INFO - 'other-e10s': {'tests': ['a11yr', 04:19:33 INFO - 'ts_paint', 04:19:33 INFO - 'tpaint', 04:19:33 INFO - 'sessionrestore', 04:19:33 INFO - 'sessionrestore_no_auto_restore', 04:19:33 INFO - 'tabpaint']}, 04:19:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:19:33 INFO - 'ts_paint', 04:19:33 INFO - 'tpaint', 04:19:33 INFO - 'sessionrestore', 04:19:33 INFO - 'sessionrestore_no_auto_restore', 04:19:33 INFO - 'tabpaint']}, 04:19:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:19:33 INFO - 'ts_paint', 04:19:33 INFO - 'tpaint', 04:19:33 INFO - 'sessionrestore', 04:19:33 INFO - 'sessionrestore_no_auto_restore', 04:19:33 INFO - 'tabpaint']}, 04:19:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:19:33 INFO - 'tests': ['a11yr', 04:19:33 INFO - 'ts_paint', 04:19:33 INFO - 'tpaint', 04:19:33 INFO - 'sessionrestore', 04:19:33 INFO - 'sessionrestore_no_auto_restore', 04:19:33 INFO - 'tabpaint']}, 04:19:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:19:33 INFO - 'tests': ['a11yr', 04:19:33 INFO - 'ts_paint', 04:19:33 INFO - 'tpaint', 04:19:33 INFO - 'sessionrestore', 04:19:33 INFO - 'sessionrestore_no_auto_restore', 04:19:33 INFO - 'tabpaint']}, 04:19:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:19:33 INFO - 'tests': ['tsvgx', 04:19:33 INFO - 'tsvgr_opacity', 04:19:33 INFO - 'tart', 04:19:33 INFO - 'tscrollx', 04:19:33 INFO - 'cart']}, 04:19:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:19:33 INFO - 'tsvgr_opacity', 04:19:33 INFO - 'tart', 04:19:33 INFO - 'tscrollx', 04:19:33 INFO - 'cart']}, 04:19:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:33 INFO - 'talos_options': ['--disable-e10s'], 04:19:33 INFO - 'tests': ['tp5o']}, 04:19:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:33 INFO - 'tests': ['tp5o']}, 04:19:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:33 INFO - 'talos_options': ['--disable-e10s', 04:19:33 INFO - '--xperf_path', 04:19:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:33 INFO - 'tests': ['tp5n']}, 04:19:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:33 INFO - 'talos_options': ['--xperf_path', 04:19:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:33 INFO - 'tests': ['tp5n']}}, 04:19:33 INFO - 'talos.zip': {'path': '', 04:19:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:19:33 INFO - Running post-action listener: _resource_record_post_action 04:19:33 INFO - ##### 04:19:33 INFO - ##### Running create-virtualenv step. 04:19:33 INFO - ##### 04:19:33 INFO - Running pre-action listener: _resource_record_pre_action 04:19:33 INFO - Running main action method: create_virtualenv 04:19:33 INFO - Creating virtualenv /builds/slave/test/build/venv 04:19:33 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 04:19:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:19:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:19:33 INFO - Using real prefix '/usr' 04:19:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:19:34 INFO - Installing distribute.............................................................................................................................................................................................done. 04:19:36 INFO - Installing pip.................done. 04:19:36 INFO - Return code: 0 04:19:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:19:36 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')]} 04:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:36 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')]} 04:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:36 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 0x7f0a6c9f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c410>, '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 0x2b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d7a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', '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 04:19:36 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 04:19:36 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 04:19:36 INFO - Using env: {'DISPLAY': ':0', 04:19:36 INFO - 'HOME': '/home/cltbld', 04:19:36 INFO - 'LANG': 'en_US.UTF-8', 04:19:36 INFO - 'LANGUAGE': 'en_US:en', 04:19:36 INFO - 'LOGNAME': 'cltbld', 04:19:36 INFO - 'MAIL': '/var/mail/cltbld', 04:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:36 INFO - 'MOZ_NO_REMOTE': '1', 04:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:36 INFO - 'NO_EM_RESTART': '1', 04:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:36 INFO - 'PWD': '/builds/slave/test', 04:19:36 INFO - 'SHELL': '/bin/bash', 04:19:36 INFO - 'SHLVL': '1', 04:19:36 INFO - 'TERM': 'linux', 04:19:36 INFO - 'TMOUT': '86400', 04:19:36 INFO - 'USER': 'cltbld', 04:19:36 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', 04:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:36 INFO - '_': '/tools/buildbot/bin/python'} 04:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:36 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 04:19:36 INFO - Cleaning up... 04:19:36 INFO - Return code: 0 04:19:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:19:36 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')]} 04:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:36 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')]} 04:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:36 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 0x7f0a6c9f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c410>, '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 0x2b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d7a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', '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 04:19:36 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 04:19:36 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 04:19:36 INFO - Using env: {'DISPLAY': ':0', 04:19:36 INFO - 'HOME': '/home/cltbld', 04:19:36 INFO - 'LANG': 'en_US.UTF-8', 04:19:36 INFO - 'LANGUAGE': 'en_US:en', 04:19:36 INFO - 'LOGNAME': 'cltbld', 04:19:36 INFO - 'MAIL': '/var/mail/cltbld', 04:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:36 INFO - 'MOZ_NO_REMOTE': '1', 04:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:36 INFO - 'NO_EM_RESTART': '1', 04:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:36 INFO - 'PWD': '/builds/slave/test', 04:19:36 INFO - 'SHELL': '/bin/bash', 04:19:36 INFO - 'SHLVL': '1', 04:19:36 INFO - 'TERM': 'linux', 04:19:36 INFO - 'TMOUT': '86400', 04:19:36 INFO - 'USER': 'cltbld', 04:19:36 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', 04:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:36 INFO - '_': '/tools/buildbot/bin/python'} 04:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:36 INFO - Downloading/unpacking psutil>=0.7.1 04:19:36 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 04:19:36 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 04:19:36 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 04:19:36 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 04:19:36 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 04:19:36 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 04:19:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:19:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:19:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:19:38 INFO - Installing collected packages: psutil 04:19:38 INFO - Running setup.py install for psutil 04:19:38 INFO - building 'psutil._psutil_linux' extension 04:19:38 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 04:19:38 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 04:19:38 INFO - building 'psutil._psutil_posix' extension 04:19:38 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 04:19:39 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 04:19:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:19:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:19:39 INFO - Successfully installed psutil 04:19:39 INFO - Cleaning up... 04:19:39 INFO - Return code: 0 04:19:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:39 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 0x7f0a6c9f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c410>, '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 0x2b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d7a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', '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 04:19:39 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 04:19:39 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 04:19:39 INFO - Using env: {'DISPLAY': ':0', 04:19:39 INFO - 'HOME': '/home/cltbld', 04:19:39 INFO - 'LANG': 'en_US.UTF-8', 04:19:39 INFO - 'LANGUAGE': 'en_US:en', 04:19:39 INFO - 'LOGNAME': 'cltbld', 04:19:39 INFO - 'MAIL': '/var/mail/cltbld', 04:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:39 INFO - 'MOZ_NO_REMOTE': '1', 04:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:39 INFO - 'NO_EM_RESTART': '1', 04:19:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:39 INFO - 'PWD': '/builds/slave/test', 04:19:39 INFO - 'SHELL': '/bin/bash', 04:19:39 INFO - 'SHLVL': '1', 04:19:39 INFO - 'TERM': 'linux', 04:19:39 INFO - 'TMOUT': '86400', 04:19:39 INFO - 'USER': 'cltbld', 04:19:39 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', 04:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:39 INFO - '_': '/tools/buildbot/bin/python'} 04:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:19:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:19:41 INFO - Installing collected packages: mozsystemmonitor 04:19:41 INFO - Running setup.py install for mozsystemmonitor 04:19:41 INFO - Successfully installed mozsystemmonitor 04:19:41 INFO - Cleaning up... 04:19:41 INFO - Return code: 0 04:19:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:19: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')]} 04:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19: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')]} 04:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:41 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 0x7f0a6c9f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c410>, '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 0x2b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d7a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', '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 04:19:41 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 04:19:41 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 04:19:41 INFO - Using env: {'DISPLAY': ':0', 04:19:41 INFO - 'HOME': '/home/cltbld', 04:19:41 INFO - 'LANG': 'en_US.UTF-8', 04:19:41 INFO - 'LANGUAGE': 'en_US:en', 04:19:41 INFO - 'LOGNAME': 'cltbld', 04:19:41 INFO - 'MAIL': '/var/mail/cltbld', 04:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:41 INFO - 'MOZ_NO_REMOTE': '1', 04:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:41 INFO - 'NO_EM_RESTART': '1', 04:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:41 INFO - 'PWD': '/builds/slave/test', 04:19:41 INFO - 'SHELL': '/bin/bash', 04:19:41 INFO - 'SHLVL': '1', 04:19:41 INFO - 'TERM': 'linux', 04:19:41 INFO - 'TMOUT': '86400', 04:19:41 INFO - 'USER': 'cltbld', 04:19:41 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', 04:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:41 INFO - '_': '/tools/buildbot/bin/python'} 04:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:41 INFO - Downloading/unpacking blobuploader==1.2.4 04:19:41 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 04:19:41 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 04:19:41 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 04:19:41 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 04:19:41 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 04:19:41 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 04:19:43 INFO - Downloading blobuploader-1.2.4.tar.gz 04:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:19:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:19:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:19:44 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 04:19:44 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 04:19:44 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 04:19:44 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 04:19:44 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 04:19:44 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 04:19:44 INFO - Downloading docopt-0.6.1.tar.gz 04:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:19:44 INFO - Installing collected packages: blobuploader, requests, docopt 04:19:44 INFO - Running setup.py install for blobuploader 04:19:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:19:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:19:44 INFO - Running setup.py install for requests 04:19:44 INFO - Running setup.py install for docopt 04:19:44 INFO - Successfully installed blobuploader requests docopt 04:19:44 INFO - Cleaning up... 04:19:44 INFO - Return code: 0 04:19:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:44 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 0x7f0a6c9f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c410>, '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 0x2b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d7a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', '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 04:19:44 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 04:19:44 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 04:19:44 INFO - Using env: {'DISPLAY': ':0', 04:19:44 INFO - 'HOME': '/home/cltbld', 04:19:44 INFO - 'LANG': 'en_US.UTF-8', 04:19:44 INFO - 'LANGUAGE': 'en_US:en', 04:19:44 INFO - 'LOGNAME': 'cltbld', 04:19:44 INFO - 'MAIL': '/var/mail/cltbld', 04:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:44 INFO - 'MOZ_NO_REMOTE': '1', 04:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:44 INFO - 'NO_EM_RESTART': '1', 04:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:44 INFO - 'PWD': '/builds/slave/test', 04:19:44 INFO - 'SHELL': '/bin/bash', 04:19:44 INFO - 'SHLVL': '1', 04:19:44 INFO - 'TERM': 'linux', 04:19:44 INFO - 'TMOUT': '86400', 04:19:44 INFO - 'USER': 'cltbld', 04:19:44 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', 04:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:44 INFO - '_': '/tools/buildbot/bin/python'} 04:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:19:45 INFO - Running setup.py (path:/tmp/pip-1QTbCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:19:45 INFO - Running setup.py (path:/tmp/pip-Hti_DF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:19:45 INFO - Running setup.py (path:/tmp/pip-3q1JKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:19:45 INFO - Running setup.py (path:/tmp/pip-wvJPPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:19:45 INFO - Running setup.py (path:/tmp/pip-ZXtlkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:19:45 INFO - Running setup.py (path:/tmp/pip-jM7QKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:19:45 INFO - Running setup.py (path:/tmp/pip-iomH09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:19:45 INFO - Running setup.py (path:/tmp/pip-xbWZAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:19:45 INFO - Running setup.py (path:/tmp/pip-iS6G6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:19:45 INFO - Running setup.py (path:/tmp/pip-_N9Gw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:19:45 INFO - Running setup.py (path:/tmp/pip-pbKf5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:19:45 INFO - Running setup.py (path:/tmp/pip-uv2iVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:19:45 INFO - Running setup.py (path:/tmp/pip-KuYv2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:19:46 INFO - Running setup.py (path:/tmp/pip-CvVsaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:46 INFO - Running setup.py (path:/tmp/pip-uNlOvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:19:46 INFO - Running setup.py (path:/tmp/pip-jAjXwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:19:46 INFO - Running setup.py (path:/tmp/pip-q_RqT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:19:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:19:46 INFO - Running setup.py install for manifestparser 04:19:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:19:46 INFO - Running setup.py install for mozcrash 04:19:46 INFO - Running setup.py install for mozdebug 04:19:46 INFO - Running setup.py install for mozdevice 04:19:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:19:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:19:46 INFO - Running setup.py install for mozfile 04:19:46 INFO - Running setup.py install for mozhttpd 04:19:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:19:46 INFO - Running setup.py install for mozinfo 04:19:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:19:47 INFO - Running setup.py install for mozInstall 04:19:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:19:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:19:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:19:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:19:47 INFO - Running setup.py install for mozleak 04:19:47 INFO - Running setup.py install for mozlog 04:19:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:19:47 INFO - Running setup.py install for moznetwork 04:19:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:19:47 INFO - Running setup.py install for mozprocess 04:19:47 INFO - Running setup.py install for mozprofile 04:19:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:19:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:19:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:19:47 INFO - Running setup.py install for mozrunner 04:19:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:19:47 INFO - Running setup.py install for mozscreenshot 04:19:47 INFO - Running setup.py install for moztest 04:19:48 INFO - Running setup.py install for mozversion 04:19:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:19:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:19:48 INFO - Cleaning up... 04:19:48 INFO - Return code: 0 04:19:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:48 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 0x7f0a6c9f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c410>, '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 0x2b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d7a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', '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 04:19:48 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 04:19:48 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 04:19:48 INFO - Using env: {'DISPLAY': ':0', 04:19:48 INFO - 'HOME': '/home/cltbld', 04:19:48 INFO - 'LANG': 'en_US.UTF-8', 04:19:48 INFO - 'LANGUAGE': 'en_US:en', 04:19:48 INFO - 'LOGNAME': 'cltbld', 04:19:48 INFO - 'MAIL': '/var/mail/cltbld', 04:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:48 INFO - 'MOZ_NO_REMOTE': '1', 04:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:48 INFO - 'NO_EM_RESTART': '1', 04:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:48 INFO - 'PWD': '/builds/slave/test', 04:19:48 INFO - 'SHELL': '/bin/bash', 04:19:48 INFO - 'SHLVL': '1', 04:19:48 INFO - 'TERM': 'linux', 04:19:48 INFO - 'TMOUT': '86400', 04:19:48 INFO - 'USER': 'cltbld', 04:19:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', 04:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:48 INFO - '_': '/tools/buildbot/bin/python'} 04:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:19:48 INFO - Running setup.py (path:/tmp/pip-s4kFOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:19:48 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)) 04:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:19:48 INFO - Running setup.py (path:/tmp/pip-7126wT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:19:48 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)) 04:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:19:48 INFO - Running setup.py (path:/tmp/pip-PbOKzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:19:48 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)) 04:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:19:48 INFO - Running setup.py (path:/tmp/pip-5Db31g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:19:48 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)) 04:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:19:48 INFO - Running setup.py (path:/tmp/pip-czbEQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:19:48 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)) 04:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:19:48 INFO - Running setup.py (path:/tmp/pip-K6G1Kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:19:48 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)) 04:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:19:48 INFO - Running setup.py (path:/tmp/pip-af2aN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:19:48 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)) 04:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:19:48 INFO - Running setup.py (path:/tmp/pip-So23CQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:19:48 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)) 04:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:19:48 INFO - Running setup.py (path:/tmp/pip-tOYGsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:19:48 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)) 04:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:19:49 INFO - Running setup.py (path:/tmp/pip-49W2To-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:19:49 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)) 04:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:19:49 INFO - Running setup.py (path:/tmp/pip-cZtO_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:19:49 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)) 04:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:19:49 INFO - Running setup.py (path:/tmp/pip-BkXvQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:19:49 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)) 04:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:19:49 INFO - Running setup.py (path:/tmp/pip-jKoIeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:19:49 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)) 04:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:19:49 INFO - Running setup.py (path:/tmp/pip-f0IZKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:19:49 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)) 04:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:49 INFO - Running setup.py (path:/tmp/pip-UGzuJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:49 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)) 04:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:19:49 INFO - Running setup.py (path:/tmp/pip-Q212KU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:19:49 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)) 04:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:19:49 INFO - Running setup.py (path:/tmp/pip-mjh2TE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:19:49 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)) 04:19:49 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)) 04:19:49 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)) 04:19:49 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)) 04:19:49 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)) 04:19:49 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)) 04:19:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:19:49 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 04:19:49 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 04:19:49 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 04:19:49 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 04:19:49 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 04:19:49 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 04:19:51 INFO - Downloading blessings-1.6.tar.gz 04:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:19:51 INFO - Installing collected packages: blessings 04:19:51 INFO - Running setup.py install for blessings 04:19:51 INFO - Successfully installed blessings 04:19:51 INFO - Cleaning up... 04:19:51 INFO - Return code: 0 04:19:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:19:51 INFO - Reading from file tmpfile_stdout 04:19:51 INFO - Current package versions: 04:19:51 INFO - argparse == 1.2.1 04:19:51 INFO - blessings == 1.6 04:19:51 INFO - blobuploader == 1.2.4 04:19:51 INFO - docopt == 0.6.1 04:19:51 INFO - manifestparser == 1.1 04:19:51 INFO - mozInstall == 1.12 04:19:51 INFO - mozcrash == 0.17 04:19:51 INFO - mozdebug == 0.1 04:19:51 INFO - mozdevice == 0.48 04:19:51 INFO - mozfile == 1.2 04:19:51 INFO - mozhttpd == 0.7 04:19:51 INFO - mozinfo == 0.9 04:19:51 INFO - mozleak == 0.1 04:19:51 INFO - mozlog == 3.1 04:19:51 INFO - moznetwork == 0.27 04:19:51 INFO - mozprocess == 0.22 04:19:51 INFO - mozprofile == 0.28 04:19:51 INFO - mozrunner == 6.11 04:19:51 INFO - mozscreenshot == 0.1 04:19:51 INFO - mozsystemmonitor == 0.0 04:19:51 INFO - moztest == 0.7 04:19:51 INFO - mozversion == 1.4 04:19:51 INFO - psutil == 3.1.1 04:19:51 INFO - requests == 1.2.3 04:19:51 INFO - wsgiref == 0.1.2 04:19:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:19: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')]} 04:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19: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')]} 04:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:51 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 0x7f0a6c9f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c410>, '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 0x2b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d7a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', '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 04:19:51 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 04:19:51 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 04:19:51 INFO - Using env: {'DISPLAY': ':0', 04:19:51 INFO - 'HOME': '/home/cltbld', 04:19:51 INFO - 'LANG': 'en_US.UTF-8', 04:19:51 INFO - 'LANGUAGE': 'en_US:en', 04:19:51 INFO - 'LOGNAME': 'cltbld', 04:19:51 INFO - 'MAIL': '/var/mail/cltbld', 04:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:51 INFO - 'MOZ_NO_REMOTE': '1', 04:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:51 INFO - 'NO_EM_RESTART': '1', 04:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:51 INFO - 'PWD': '/builds/slave/test', 04:19:51 INFO - 'SHELL': '/bin/bash', 04:19:51 INFO - 'SHLVL': '1', 04:19:51 INFO - 'TERM': 'linux', 04:19:51 INFO - 'TMOUT': '86400', 04:19:51 INFO - 'USER': 'cltbld', 04:19:51 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', 04:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:51 INFO - '_': '/tools/buildbot/bin/python'} 04:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:52 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)) 04:19:52 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)) 04:19:52 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)) 04:19:52 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)) 04:19:52 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)) 04:19:52 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)) 04:19:52 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)) 04:19:52 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)) 04:19:52 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)) 04:19:52 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)) 04:19:52 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)) 04:19:52 INFO - Cleaning up... 04:19:52 INFO - Return code: 0 04:19:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:19:52 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')]} 04:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:52 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')]} 04:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:52 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 0x7f0a6c9f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c410>, '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 0x2b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d7a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', '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 04:19:52 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 04:19:52 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 04:19:52 INFO - Using env: {'DISPLAY': ':0', 04:19:52 INFO - 'HOME': '/home/cltbld', 04:19:52 INFO - 'LANG': 'en_US.UTF-8', 04:19:52 INFO - 'LANGUAGE': 'en_US:en', 04:19:52 INFO - 'LOGNAME': 'cltbld', 04:19:52 INFO - 'MAIL': '/var/mail/cltbld', 04:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:52 INFO - 'MOZ_NO_REMOTE': '1', 04:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:52 INFO - 'NO_EM_RESTART': '1', 04:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:52 INFO - 'PWD': '/builds/slave/test', 04:19:52 INFO - 'SHELL': '/bin/bash', 04:19:52 INFO - 'SHLVL': '1', 04:19:52 INFO - 'TERM': 'linux', 04:19:52 INFO - 'TMOUT': '86400', 04:19:52 INFO - 'USER': 'cltbld', 04:19:52 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', 04:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:52 INFO - '_': '/tools/buildbot/bin/python'} 04:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:52 INFO - Downloading/unpacking jsonschema 04:19: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 04:19: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 04:19: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 04:19: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 04:19: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 04:19: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 04:19:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:19:54 INFO - Downloading/unpacking functools32 (from jsonschema) 04:19: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 04:19: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 04:19: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 04:19: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 04:19: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 04:19: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 04:19:54 INFO - Downloading functools32-3.2.3-2.tar.gz 04:19:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:19:54 INFO - warning: no files found matching '*.txt' 04:19:54 INFO - no previously-included directories found matching 'build' 04:19:54 INFO - no previously-included directories found matching 'dist' 04:19:54 INFO - no previously-included directories found matching '.git*' 04:19:54 INFO - Installing collected packages: jsonschema, functools32 04:19:54 INFO - Running setup.py install for functools32 04:19:54 INFO - warning: no files found matching '*.txt' 04:19:54 INFO - no previously-included directories found matching 'build' 04:19:54 INFO - no previously-included directories found matching 'dist' 04:19:54 INFO - no previously-included directories found matching '.git*' 04:19:54 INFO - Successfully installed jsonschema functools32 04:19:54 INFO - Cleaning up... 04:19:54 INFO - Return code: 0 04:19:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:19: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')]} 04:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19: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')]} 04:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0a6c9f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2afd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c410>, '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 0x2b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d7a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', '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 04:19: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', 'flake8'] in /builds/slave/test/build 04:19: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 flake8 04:19:54 INFO - Using env: {'DISPLAY': ':0', 04:19:54 INFO - 'HOME': '/home/cltbld', 04:19:54 INFO - 'LANG': 'en_US.UTF-8', 04:19:54 INFO - 'LANGUAGE': 'en_US:en', 04:19:54 INFO - 'LOGNAME': 'cltbld', 04:19:54 INFO - 'MAIL': '/var/mail/cltbld', 04:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:54 INFO - 'MOZ_NO_REMOTE': '1', 04:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:54 INFO - 'NO_EM_RESTART': '1', 04:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:54 INFO - 'PWD': '/builds/slave/test', 04:19:54 INFO - 'SHELL': '/bin/bash', 04:19:54 INFO - 'SHLVL': '1', 04:19:54 INFO - 'TERM': 'linux', 04:19:54 INFO - 'TMOUT': '86400', 04:19:54 INFO - 'USER': 'cltbld', 04:19:54 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', 04:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:54 INFO - '_': '/tools/buildbot/bin/python'} 04:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:54 INFO - Downloading/unpacking flake8 04:19: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 04:19: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 04:19: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 04:19: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 04:19: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 04:19: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 04:19:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:19:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:19:56 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 04:19:56 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 04:19:56 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 04:19:56 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 04:19:56 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 04:19:56 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 04:19:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:19:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:19: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 04:19: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 04:19: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 04:19: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 04:19: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 04:19: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 04:19:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:19: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 04:19: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 04:19: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 04:19: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 04:19: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 04:19: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 04:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:19:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:19:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:19:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:19:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:19:57 INFO - no previously-included directories found matching 'docs/_build' 04:19:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:19:57 INFO - Running setup.py install for pep8 04:19:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:19:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:19:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:19:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:19:57 INFO - no previously-included directories found matching 'docs/_build' 04:19:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:19:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:19:57 INFO - Cleaning up... 04:19:57 INFO - Return code: 0 04:19:57 INFO - Running post-action listener: _resource_record_post_action 04:19:57 INFO - Running post-action listener: _start_resource_monitoring 04:19:57 INFO - Starting resource monitoring. 04:19:57 INFO - ##### 04:19:57 INFO - ##### Running install step. 04:19:57 INFO - ##### 04:19:57 INFO - Running pre-action listener: _resource_record_pre_action 04:19:57 INFO - Running main action method: install 04:19:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:19:57 INFO - Reading from file tmpfile_stdout 04:19:57 INFO - Detecting whether we're running mozinstall >=1.0... 04:19:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:19:58 INFO - Reading from file tmpfile_stdout 04:19:58 INFO - Output received: 04:19:58 INFO - Usage: mozinstall [options] installer 04:19:58 INFO - Options: 04:19:58 INFO - -h, --help show this help message and exit 04:19:58 INFO - -d DEST, --destination=DEST 04:19:58 INFO - Directory to install application into. [default: 04:19:58 INFO - "/builds/slave/test"] 04:19:58 INFO - --app=APP Application being installed. [default: firefox] 04:19:58 INFO - mkdir: /builds/slave/test/build/application 04:19:58 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'] 04:19:58 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 04:20:13 INFO - Reading from file tmpfile_stdout 04:20:13 INFO - Output received: 04:20:13 INFO - /builds/slave/test/build/application/firefox/firefox 04:20:13 INFO - Running post-action listener: _resource_record_post_action 04:20:13 INFO - ##### 04:20:13 INFO - ##### Running run-tests step. 04:20:13 INFO - ##### 04:20:13 INFO - Running pre-action listener: _resource_record_pre_action 04:20:13 INFO - Running main action method: run_tests 04:20:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:20:13 INFO - Python 2.7.3 04:20:13 INFO - Return code: 0 04:20:13 INFO - grabbing minidump binary from tooltool 04:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:13 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 0x2b8c410>, '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 0x2b8d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:20:13 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 04:20:13 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 04:20:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:20:13 INFO - Return code: 0 04:20:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:20:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:20:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:20:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:20:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:20:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:20:14 INFO - Return code: 0 04:20:14 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/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 04:20:14 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/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 04:20:14 INFO - Using env: {'DISPLAY': ':0', 04:20:14 INFO - 'HOME': '/home/cltbld', 04:20:14 INFO - 'LANG': 'en_US.UTF-8', 04:20:14 INFO - 'LANGUAGE': 'en_US:en', 04:20:14 INFO - 'LOGNAME': 'cltbld', 04:20:14 INFO - 'MAIL': '/var/mail/cltbld', 04:20:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:20:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:14 INFO - 'MOZ_NO_REMOTE': '1', 04:20:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:14 INFO - 'NO_EM_RESTART': '1', 04:20:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:14 INFO - 'PWD': '/builds/slave/test', 04:20:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:20:14 INFO - 'SHELL': '/bin/bash', 04:20:14 INFO - 'SHLVL': '1', 04:20:14 INFO - 'TERM': 'linux', 04:20:14 INFO - 'TMOUT': '86400', 04:20:14 INFO - 'USER': 'cltbld', 04:20:14 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708', 04:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:14 INFO - '_': '/tools/buildbot/bin/python'} 04:20:14 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/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 04:20:14 INFO - mozversion application_buildid: 20160408030202 04:20:14 INFO - mozversion application_changeset: d9b1a9829c8ee2862955043f28183efa07de3d2b 04:20:14 INFO - mozversion application_display_name: Nightly 04:20:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:20:14 INFO - mozversion application_name: Firefox 04:20:14 INFO - mozversion application_remotingname: firefox 04:20:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:20:14 INFO - mozversion application_vendor: Mozilla 04:20:14 INFO - mozversion application_version: 48.0a1 04:20:14 INFO - mozversion platform_buildid: 20160408030202 04:20:14 INFO - mozversion platform_changeset: d9b1a9829c8ee2862955043f28183efa07de3d2b 04:20:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:20:14 INFO - mozversion platform_version: 48.0a1 04:20:14 INFO - using testdate: 1460114414 04:20:14 INFO - actual date: 1460114414 04:20:14 INFO - starting webserver on 'localhost:42756' 04:20:14 INFO - SUITE-START | Running 2 tests 04:20:14 INFO - TEST-START | dromaeo_css 04:20:14 INFO - operating with platform_type : linux_ 04:20:14 INFO - Initialising browser for dromaeo_css test... 04:20:14 INFO - TEST-INFO | started process 4714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8hwpOS/profile http://localhost:42756/getInfo.html) 04:20:19 INFO - PROCESS | 4714 | __metrics Screen width/height:1600/1200 04:20:19 INFO - PROCESS | 4714 | colorDepth:24 04:20:19 INFO - PROCESS | 4714 | Browser inner width/height: 1024/697 04:20:19 INFO - PROCESS | 4714 | __metrics 04:20:20 ERROR - PROCESS | 4714 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:20:21 INFO - TEST-INFO | 4714: exit 0 04:20:21 INFO - Browser initialized. 04:20:21 INFO - Running cycle 1/1 for dromaeo_css test... 04:20:21 INFO - TEST-INFO | started process 4795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8hwpOS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:33 INFO - PROCESS | 4795 | RSS: Main: 155070464 04:20:33 INFO - PROCESS | 4795 | 04:21:24 INFO - PROCESS | 4795 | 1460114484298 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] 04:23:35 INFO - PROCESS | 4795 | Cycle 1(1): loaded http://localhost:42756/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42756/tests/dromaeo/cssquery-ext.html) 04:23:37 INFO - PROCESS | 4795 | RSS: Main: 271986688 04:23:37 INFO - PROCESS | 4795 | 04:26:39 INFO - PROCESS | 4795 | Cycle 1(1): loaded http://localhost:42756/tests/dromaeo/cssquery-ext.html (next: http://localhost:42756/tests/dromaeo/cssquery-jquery.html) 04:26:40 INFO - PROCESS | 4795 | RSS: Main: 234074112 04:26:40 INFO - PROCESS | 4795 | 04:29:42 INFO - PROCESS | 4795 | Cycle 1(1): loaded http://localhost:42756/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42756/tests/dromaeo/cssquery-mootools.html) 04:29:42 INFO - PROCESS | 4795 | RSS: Main: 232120320 04:29:42 INFO - PROCESS | 4795 | 04:32:45 INFO - PROCESS | 4795 | Cycle 1(1): loaded http://localhost:42756/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42756/tests/dromaeo/cssquery-prototype.html) 04:32:45 INFO - PROCESS | 4795 | RSS: Main: 202014720 04:32:45 INFO - PROCESS | 4795 | 04:35:48 INFO - PROCESS | 4795 | Cycle 1(1): loaded http://localhost:42756/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42756/tests/dromaeo/cssquery-yui.html) 04:35:49 INFO - PROCESS | 4795 | RSS: Main: 206917632 04:35:49 INFO - PROCESS | 4795 | 04:38:51 INFO - PROCESS | 4795 | Cycle 1(1): loaded http://localhost:42756/tests/dromaeo/cssquery-yui.html (next: http://localhost:42756/tests/dromaeo/cssquery-dojo.html) 04:38:52 INFO - PROCESS | 4795 | RSS: Main: 269406208 04:38:52 INFO - PROCESS | 4795 | 04:38:52 INFO - PROCESS | 4795 | __start_tp_report 04:38:52 INFO - PROCESS | 4795 | _x_x_mozilla_page_load 04:38:52 INFO - PROCESS | 4795 | _x_x_mozilla_page_load_details 04:38:52 INFO - PROCESS | 4795 | |i|pagename|runs| 04:38:52 INFO - PROCESS | 4795 | |0;dojo.html;2576.587745960646;2641.115226399156;2659.4681063787248;2683.6377089092966;2696.608991696204;4503.932441013388;4504.436945381827;4520;4566.31505274209;4576.016156526346;4500.504944456107;4526.411566496359;4568.063546972871;4569.6801223914335;4601.010782681723;4164.10471748574;4181.435506206662;4213.0520632857515;4246.893827654318;4330.631896288819;4281.058167203226;4288.528261891205;4299.484061912559;4319.157764235975;4342.5874541918465;4129.112240868198;4141.316682747343;4212.241796476633;4214.599613036757;4218.367244913257;4233.407322974786;4235.428217190671;4241;4277.508086570022;4277.871663850058;4206.789660516962;4216.894577635584;4236.04688944988;4242.469691288589;4259.744415335059;4396.582324679151;4448.666350023761;4532.546745325474;4533.863984080483;4535.070310586322;4861.586765124968;4878.902421951577;4879.365682461293;4882;4909.705417674951;4896.730679812609;4902.534259245366;4903.632227582945;4912.680675756064;4953.876153096166;4508.323751437278;4564.771761411983;4571.1771881061395;4652.767361631905;4663.860084197479;5006.874828129253;5030.2957585938;5032.647714660012;5036.471170527115;5064.240363945364;4833.734144622009;4836.661433699607;4838.274258861128;4840.177169881129;4880.41435027799;4787.952120478821;4887.780049897763;4961.627877909099;4988.426330971912;4990.151674215392;4854.83008094715;4858.44127925286;4866.586340161055;4875.804967801319;4928.778204980785;4852.1508735971065;4856.1987272099705;4856.465788763233;4859.708417494961;4909.975450122726;4075.5109386873173;4098.098418347959;4099.385092236129;4156.314208155621;4178.101708132766;3622.746407751432;3642.508261384732;3643.3259846928404;3662.5788034375855;3681.5950245472977;4267.466566679165;4276.743395396286;4279.550647182001;4283.357496375568;4325.24308246062;4789.760511974388;4844.0554091951735;4891.902161956812;4927.802887884516;4938.160512712848;4232.809523571446;4235.449391579136;4245.490541135022;4246.384274280212;4286.185624731291;4331.112122014979;4367.497737760134;4405.581469760367;4443.244648409778;4449.9777501112285;4620.168369693421;4657.767111644472;4659.60393366554;4704.05918816245;4705.505921878222;4883.60931125502;4888.413390393175;4897.755112244445;4899.877503062309;4922.606191504743;4543.204939135704;4606.884827879196;4610.054938737484;4612.815487380467;4664.370310008106;4799.112164249625;4813;4820.71075735457;4848.75756212195;4868.14807408695;4842.58837998774;4878.56092951636;4878.780454879468;4886.9022619546695;4931.852044438672;4637.675362724577;4691.5308469152815;4746.92879606813;4751.976240118777;4792.856214313576;4790.161721698619;4802.087603355351;4807.879803004953;4826.420829500483;4857.149998750134;4723.45680246776;4724.706630182603;4725.054989002145;4727.267273572602;4784.880377990578;4656.580907718321;4711.057788442256;4723.763811809465;4804.735739534359;4821.397325334333;4671.556202160789;4712.717236965793;4713.481517033192;4734.360861283682;4749.738764367993 04:38:52 INFO - PROCESS | 4795 | |1;ext.html;565.9377468478467;586.7799575159314;616.223558316521;620.4663988969488;629.4115002472691;25991.740082599194;33015.33969320612;33769.49345759815;33857.153571160736;33982.49026264608;36590.45114323281;37305.62694373055;37416.812915935385;37438.25123497535;37475;7531.811704707371;7706.576138312391;7714.575698336589;7715.151333353327;7718.151003389623;7565.35694465971;7659.961700191491;7663.69345226193;7670.808229794272;7676.501027433227;7663.846723065535;7861.921380786176;7864.488808227476;7868.685252589889;7877.291043806056;7796.298333150015;7854.764357069297;7855.607219638995;7862.488938218998;7865.567393793339;7685.500442471277;7797.649105790253;7801.375889928792;7811.257930496594;7812;37038;37450.25099498022;37552;37554.81222593897;37603.43594846079;2931.2525306047037;3076.107928700674;3083.090488305933;3114.797538160012;3163.7785355025158;27870.721292787017;27983.160505184675;28118.718812811814;29101.854490727623;29232.123036308945;3451.8274086295837;3463.3765922134007;3473.9652603473896;3483.372992861284;3510.4383298672346;330937;341840;342466;343351;343522;48104.27843582279;51311;51647.48352516502;51727.22409163866;51852.481475184766;57776.42223577711;59251;59361.10958335629;59376;59419.40580594139;13033.543825966046;13166.210027398387;13168;13176.47294108225;13177.341132943315;9754.707358779247;10523.94738026305;10604.681859544226;10697.83953240702;11070.114390848712;17434.389796357067;17523.649527009387;17529.7370539442;17556.2099705511;17609.38367157169;6567.573107747981;6622.337766223339;6637.834054148685;6650.168728908887;6825.317468253135;866.328595338605;880.126387345318;967.9128878400978;973.3332667123043;1048.4810019040624;27691.86154069257;28011.859940700167;28567.142985710463;28620.427591448053;28720.856395718307;976.8876579193342;1007.8185926533148;1043.1915265669168;1046.9162467002623;1076.7469644633504;14615.415383384545;15085.47200847965;15268.16025118607;15305.846941530443;15460.92269538645;311790;316054;317632;318244;318702;47254.5274547257;48073.27890081651;48082.51917480781;48211.75894120507;48289.27566086512;1075.8547596074586;1198.1313547678037;1234.3211233821362;1253.899688024974;1273.8598754137038;24341.480481831924;25632.8718356407;26242.737572624028;26362.34094147585;26388;35342.64657353394;36067.639323606425;36194.4570831443;36195.63804361923;36200;211592;212115;212283;212380;212831;22248.110075597444;22994.19520316781;24819.379515512257;25771.355716107246;26041.73958260469;35907.82046089753;35988.28023439569;36007.279854402244;36286;37118.62881371152;30260.5460918082;31357.686423135478;32511.512327314635;34206.48690269598;34655.18792932725;33574;33625.495617566245;34272.82863585766;34382.312353752284;34505.82747086249;29980.95066672656;30230;30420.391592168475;31845.36309273848;34678.65321346754;29624.85187574048;30528.542071868495;30667.693323067375;30700.84649576738;30855.69144308528;23472.178473753338;23656.97584526617;23663.763362366157;24000.87999559991;24305.14931977372 04:38:52 INFO - PROCESS | 4795 | |2;jquery.html;376.5075202161689;388.469738806529;389.16135727507213;393.08019234990115;400.0937875711512;15527.378904843807;16911.154442277897;16972.321107155716;17120.657586848254;17152.142392880367;15912;16831.41090061848;16868.072256025913;16870.240839162238;16870.409535666255;4895.339129217546;5106.259592359106;5148.536631703146;5174.016936782018;5179.041877252702;3537.168765340156;3801.2397520495874;5607.523360514361;5971.940280597182;5981.491573216282;5747.770089196448;5915.615484993483;5920.052791553352;5950.464458198761;5952.8214153575245;5694.5159661428825;5838.007538718428;5916.26046744157;5926.970365148169;5929.080992446156;3263.6083669959758;3504.1414853360834;3504.737144714157;3511.20997775501;4907.631927605408;19626.313079042164;20410.897945510325;20450.488737781525;20459.897700511552;20641.690374644393;1862.3854128137818;1992.7733504924981;2256.0975609756065;2511.1336588876807;2570.0876188953025;12674.36628168597;12896.419661115273;13113.934430327883;13426.798598021038;13658.931705341509;1719.6904557179703;1803.7655104836288;1832.239620557467;1840.8527317814542;1866.2721538599958;64345.35654643441;65141;65182.67408662974;67062.9940550897;67485.66257168732;9207.539623018956;9279.164875161268;9631.422114673142;9792.951035244778;9809.19349518745;13361;13440.260785656883;13468.39392227352;13469.461221551224;13491.055626106274;7055.2239253682055;7263.709451621981;7282.672279747424;7297.635118244173;7338.816529586697;6791.252962174157;6855.5543889647015;6871.175458944958;6964.94534112438;6969.721211151598;6060.424289684625;6121.296050954197;6147.72335244915;6162.291336496361;6171.321154672983;1619.9757003644954;1699.9320027199021;1779.3861117914557;1788.9552761181073;1812;831.9126491718404;877.9078196789372;879.6613303878053;892.2282225874701;1032.9070383665505;15427.46003889881;16087.115208663636;17352.3059077638;17374.95750254989;17624.383146590066;857.9356548258905;880.2210044111008;907.3467103685336;951.8381875081253;969;9745.56144973478;9928.702138935843;9943.651972181084;9953.303268771262;10056.899431005742;380462;403569;404209;409520;409748;61620.69189654023;62920.37079629145;64663.67668161629;65275.67362163159;65536.67231663811;951.4814426137772;961.5192403798101;974.3471873844542;975.5561219644902;978.0708327089294;14943;15114.848851511784;15132.848671513584;15381.615459613598;15604.68790624204;29934.550981734857;31024.53463198099;31157.8442107788;31556.52665209978;31900.840495797373;42930.35604465873;42978;43016.354754678076;43029.78485107554;43096;7694.422918281263;7714.190010048864;7714.4599878008;7715.884261735966;7721.996140501924;11744.236624619372;11757.823632645688;11781.587644432404;11895.702607434538;12007.279563226235;10116.544755485873;10308.036825080866;10388.168946484415;10489.842652360374;10593.947030265108;10606.522706478072;10657.680269591925;10689.412082335235;10721.946390267998;10828.675139745821;10589.311694739818;10784.352938823695;10815.669759033764;10870.510827012646;11062.612808551663;7337.119545654556;7548.094228692592;7557.735479258419;7620.542767433972;7658;10811.675649730521;10942.945285273523;11011.394373309224;11023.228374013743;11069.114470842153 04:38:52 INFO - PROCESS | 4795 | |3;mootools.html;1267.8732126787318;1461.1671347332026;1467.8605532474414;1610.6537094524674;1786.7677201963743;6527.510436717242;7352.117745870496;7593.544387336757;7609.961950190255;7644.808879778008;7276.527025743323;7471.887921681179;7486.47594668372;7487.288707572786;7492.363149132317;1907.7138429235588;1948.4154753573941;1963.5483838717103;2203.8787866667326;2244.517428752818;2228.253535065755;2297.414159389362;2298.367948814073;2302.5625131225097;2302.643090321003;2190.8247340212743;2202.1081462007833;2208.8232941364654;2210.1159536185573;2234.20685656592;2217.2793842001333;2218.545198234358;2224.165937773335;2228.543148654522;2232.8771917544527;2133.3173384516963;2159.492519257973;2159.6436587962967;2179.8692078475183;2192.6930229767845;7588.810279742996;7629.6948122075055;7631.961840190819;7643.312101910799;7647.770566883002;4430.180416622935;4576.061907308994;4589.036302376505;4606.516315786827;4631.60631346336;2828.0808737160505;2890.927726806826;2916.1834686287875;2918.1974956886816;2930.0623800383887;970.9029097090305;1002.8144793213279;1011.4942528735633;1018.0989824005734;1027.547878933267;10067.345622534513;10207.234457415723;10222.948885255526;10314.638987635471;10320.483975801255;4152.563980782034;4158.37624356349;4287.742735435884;4371.715838470489;4396.362527433568;8935.731928042169;8946;8956;8956.776080597907;8968.955155224183;4565.703229290086;4568.70303430276;4582.381378513925;4604.884877878013;4609.792559334838;3573.321068996934;4092.570280120604;4160.687948403882;4209.473815773028;4238.809253583596;3650.4341827016856;3675.2833197526224;3724.0689827543115;3766.6986641068647;3794.628357276702;1213.5558685164626;1221.5358163897663;1233.1429656388723;1236.0358920042381;1256.309030033478;891.7592250092439;895.0914821456228;918.995405022984;919.6367434863191;955.8709574207533;6796.592204467748;6799.388055075067;6801.4558835293055;6804.047433359334;6807.863842723118;453.7322979442145;455.73339596335853;458.6147635985788;459.4509561074484;460.03620930163163;5608.074667679787;5707.914381284284;5769.048107062372;5769.394213607511;5770;8694.434861733967;9041.90958090424;9050.683226087187;9171;9193.586288617029;9125.771855703528;9211.355205135711;9248.075192480832;9331.626734930527;9335.94609185978;6909.170899492093;7164.534305270141;7169.211386747454;7174.174969878531;7187.496875218684;7150.141982962078;7208.747693830691;7292.307230813064;7296.598687072262;7306.561606303639;8608.397412181088;8690.087540808125;8800.16398442147;8837.232553489199;8853.911460885309;8750.343724220582;8761.605727742139;9036.277097832026;9143.542822858963;9150.49672268005;5949.107633854784;6087.239095113111;6102.298235702773;6373.649449280334;6473.482121430368;6603.075569420381;7123.786286411416;7272.272772722686;7305.744298949511;7312.341889229995;6429.7749578764515;6455;6478.967605161944;6527.336966285391;6594.208694956636;6126.724297406538;6240.687965601611;6354.841128971812;6398.5201109916015;6486.740530378732;6544;6567.868642627025;6602.471802255712;6622;6622.337766223339;6101.38986101404;6124.418180272867;6180.6291622502795;6182.072689096672;6184.443400094013;6243.250809902659;6256.843578910563;6279.089532017923;6291.307956124914;6310.400511951358 04:38:52 INFO - PROCESS | 4795 | |4;prototype.html;314.7592092049581;318.11722470145344;320.143615827661;324.2525977621584;327.8328052693126;4954.6284028697855;5043.672161309517;5047.77285022174;5082.974585127078;5083.466236045213;4968.776405061772;4998.10034193845;5005.0990821652085;5016.8494945151615;5023.120953833074;3762.7930463824478;3853.287141878747;3858.2090671412293;3973.801309934506;3992.4809774729247;3961.9603803962023;3977.86077487288;3981.343078392076;3986.3422535281643;3989.68082553395;3956.5845586213463;3960.603939606031;3962.762234265939;3968.2063587282514;3973.8211780469946;3696.7781933083834;3789.488419063419;3935.4096885467125;3956.7625942443547;3974.423708562242;3494.2312691207894;3524.436090225577;3537.9469307960403;3541.8394779184678;3544.964550354515;4835.6131509479155;4845.903081938377;4853.272009198648;4854.805807767685;4858.416989961227;4194.748315101073;4471.463424389061;4568.977155114237;4569.611583015414;4575.336576196466;5245.79016839326;5262.9474105179115;5281.551068159211;5281.947180528184;5282.445343238943;3682.502862113634;3697.759645623026;3707.0158522389465;3707.2751527627174;3712.3132220539287;5396.541293990015;5468.945310546884;5478.753456094445;5533.584981126432;5542.91685624716;3828.770273783582;3832.674222691047;3837.4052021936645;3839.347310957144;3840.6543411093135;3897.7661340319673;3904.1020565270146;3904.668103211202;3908.5700572936953;3909.257241124177;4398.934015989763;4419.226635338867;4425.424694789721;4433.135538569948;4440.4227450431235;5111.156659151273;5265.921011184835;5281.551068159172;5308.495692909168;5314.12316967696;1339.504383378137;1347.5822495026573;1354.0927578522414;1354.8306461692289;1356.4438580182077;838.6351936907465;887.1749273176008;902.5081330674798;913.410665442126;924.4268553496875;4562.703424277412;4629.560191781776;4629.629629629689;4720.669553131316;4731.929021064687;5464.316960379952;5476.424975377608;5482.205080263419;5482.424345443751;5487.2317875497465;4516.88707782308;4714.599259062949;4719.882002949885;4725.362076119749;4729.739864307496;2889.1188187602984;2899.1882272963603;2915.4606397816474;2919.4163165598598;2926.634170728659;5135.871603209875;5141.3830340358645;5148.9742551287;5149.356330458692;5154.742262886915;5424.972875135599;5470.073682966213;5569.693666848281;5581.6930068846605;5607.523360514402;5091.1090559152;5113;5131.61512886535;5140.922886156711;5161.535461808456;5433.592480563894;5453.863653408538;5468.863278418072;5477.863053423696;5498.532624726943;5248.9737551312;5344.625876188629;5381.165919282517;5394;5421.620486565903;5131.461196574306;5135.737338009369;5158.948410515847;5169.405518365285;5170.560502357342;3762.0655888407086;3768.3970564709516;3772.7924964127237;3777.2445510897383;3778.3387907115593;5374.570034397317;5470.097433923358;5486;5500.092484740133;5506.697131657797;5199.376074871039;5234.18870075139;5249.4225635180865;5312.309399778004;5320.494553017457;5286.312779338661;5288.8413347599635;5288.920666190087;5291.3385826771655;5306.787728490972;5024.321716568216;5195.246689230116;5220.686758794484;5228.555572776357;5235.293235413171;5036;5113.846584602468;5297.973510132425;5305.1776974569;5336.946630533645;5219.973900130475;5235.397929238034;5239.345081864767;5244.501772331622;5249.160134378634 04:38:52 INFO - PROCESS | 4795 | |5;yui.html;693.1716598664597;708.950373473857;718.8526352097819;719.4460265595492;729.6643543969774;10352.378857268559;10578.36529808212;10609.204309676767;10631.09635680967;10649.763549654572;11224.382658953755;11241.83137252942;11255.099592032639;11255.718607034829;11307.943460282688;631.8831016261984;759.8252401947556;776.4332037612546;786.2294950948075;790.2374208888422;788.9289963903248;790.7074382478492;794.4359504751633;794.4796158516181;795.5147360110328;824.044108833753;827.8385714785619;828.1345993436843;828.8093738440162;828.8756686497013;649.3895738006306;659.5515049766133;662.8574856405871;817.6075483767825;825.7605294464598;613.9109829074804;616.929053158888;617.062065660194;617.3517806303364;617.6109051297653;10253.79543398173;10262.589496420134;10265.589376424934;10267;10374.844377334346;12137.817932730928;12540.435680394405;12636.368181590884;12820.743585128244;12925.741485170338;10097.798044039078;10138.746531336701;10237.385756854537;10323.896761032443;10362.27464077515;3247.236899328656;3263.6573159818354;3267.9019629411155;3301.834908254578;3370.4944258361197;41095.17809643791;41602.37596436056;46478.53521464776;46566.76716616429;46614;9578.425294482353;9662.420254784736;9797;10040.748981275381;10199.082082612453;17037;17199.484015479306;17258.654826903392;17299.56751081233;17567.12164391775;7020;7052.400545953549;7105.644717764091;7148.749793757193;7228.349448549656;3572.374834403969;3596.3346780845104;3681.889543313705;3716.331060409152;3735.533058367704;2818.8872445101965;2892.305846596844;2898.347871728844;2904.0852131578486;2908.34562223498;497.1101727907078;513.0662194805418;514.3005512502993;520.9036328279204;521.9451957544479;581.7876475086648;609.7073404765737;641.4868105515569;641.8267067891643;649.1949982022353;7699.961500192463;7845.568493732785;7942.6425810838655;7953.625505971692;8206.302464290602;591.9052951527735;602.3193791016124;604.5345084285076;610.8228613702065;611.9357467465941;3802.372608519563;3873.1479074603544;3930.0764320384687;3995.780232087205;4035.6771458283856;47832.618775486284;48637.513624864005;48675.75662121738;48748.75625621849;48878;37371;38697.80651096783;42500.57499425028;43438.782806085765;43687;31654.208644783605;31709.8414507926;36448.63551364505;36886.07784805348;37779.24441511154;8027.799305017421;8125.432693984033;8462;8504.53225072627;8582.227599516074;25100;25450.109246177035;25754.87122564375;25825.354366140997;25849.870750646878;32387.19032024218;32463.675363246064;34877.128071798405;35297.823510882285;35813.2093395324;10542.894571054192;10710.678679639623;10780.353178809297;10789.352638841694;10860.945695271474;11953.880461195276;12021.45903434365;12226.14416990802;12612.054095942658;12710.682232944251;10380.117689996132;10695.89304106949;10826.89173108259;10970.122390208924;10993.340399576051;10374.221933354878;10634.468276586294;10638;10971.725706857393;11061.115110790957;10186.643467478603;10198.490075496344;10316;10526.263161578921;10887.510062047386;9349.111834375723;9523.476208808304;9705.951470242886;9818.558164882741;9843.114119729258;9183.403078799856;9400.294977876823;9741.9025809741;9748.756281093029;9770.413775173512 04:38:52 INFO - PROCESS | 4795 | __end_tp_report 04:38:52 INFO - PROCESS | 4795 | __start_cc_report 04:38:52 INFO - PROCESS | 4795 | _x_x_mozilla_cycle_collect,1095 04:38:52 INFO - PROCESS | 4795 | __end_cc_report 04:38:52 INFO - PROCESS | 4795 | __startTimestamp1460115532014__endTimestamp 04:38:52 INFO - PROCESS | 4795 | 04:38:52 INFO - PROCESS | 4795 | ------- Summary: start ------- 04:38:52 INFO - PROCESS | 4795 | Number of tests: 6 04:38:52 INFO - PROCESS | 4795 | 04:38:52 INFO - PROCESS | 4795 | [#0] dojo.html Cycles:165 Average:4532.66 Median:4659.60 stddev:457.25 (9.8%) stddev-sans-first:432.14 04:38:52 INFO - PROCESS | 4795 | Values: 2576.6 2641.1 2659.5 2683.6 2696.6 4503.9 4504.4 4520.0 4566.3 4576.0 4500.5 4526.4 4568.1 4569.7 4601.0 4164.1 4181.4 4213.1 4246.9 4330.6 4281.1 4288.5 4299.5 4319.2 4342.6 4129.1 4141.3 4212.2 4214.6 4218.4 4233.4 4235.4 4241.0 4277.5 4277.9 4206.8 4216.9 4236.0 4242.5 4259.7 4396.6 4448.7 4532.5 4533.9 4535.1 4861.6 4878.9 4879.4 4882.0 4909.7 4896.7 4902.5 4903.6 4912.7 4953.9 4508.3 4564.8 4571.2 4652.8 4663.9 5006.9 5030.3 5032.6 5036.5 5064.2 4833.7 4836.7 4838.3 4840.2 4880.4 4788.0 4887.8 4961.6 4988.4 4990.2 4854.8 4858.4 4866.6 4875.8 4928.8 4852.2 4856.2 4856.5 4859.7 4910.0 4075.5 4098.1 4099.4 4156.3 4178.1 3622.7 3642.5 3643.3 3662.6 3681.6 4267.5 4276.7 4279.6 4283.4 4325.2 4789.8 4844.1 4891.9 4927.8 4938.2 4232.8 4235.4 4245.5 4246.4 4286.2 4331.1 4367.5 4405.6 4443.2 4450.0 4620.2 4657.8 4659.6 4704.1 4705.5 4883.6 4888.4 4897.8 4899.9 4922.6 4543.2 4606.9 4610.1 4612.8 4664.4 4799.1 4813.0 4820.7 4848.8 4868.1 4842.6 4878.6 4878.8 4886.9 4931.9 4637.7 4691.5 4746.9 4752.0 4792.9 4790.2 4802.1 4807.9 4826.4 4857.1 4723.5 4724.7 4725.1 4727.3 4784.9 4656.6 4711.1 4723.8 4804.7 4821.4 4671.6 4712.7 4713.5 4734.4 4749.7 04:38:52 INFO - PROCESS | 4795 | 04:38:52 INFO - PROCESS | 4795 | [#1] ext.html Cycles:180 Average:43823.51 Median:188336.24 stddev:77602.58 (41.2%) stddev-sans-first:77752.31 04:38:52 INFO - PROCESS | 4795 | Values: 565.9 586.8 616.2 620.5 629.4 25991.7 33015.3 33769.5 33857.2 33982.5 36590.5 37305.6 37416.8 37438.3 37475.0 7531.8 7706.6 7714.6 7715.2 7718.2 7565.4 7660.0 7663.7 7670.8 7676.5 7663.8 7861.9 7864.5 7868.7 7877.3 7796.3 7854.8 7855.6 7862.5 7865.6 7685.5 7797.6 7801.4 7811.3 7812.0 37038.0 37450.3 37552.0 37554.8 37603.4 2931.3 3076.1 3083.1 3114.8 3163.8 27870.7 27983.2 28118.7 29101.9 29232.1 3451.8 3463.4 3474.0 3483.4 3510.4 330937.0 341840.0 342466.0 343351.0 343522.0 48104.3 51311.0 51647.5 51727.2 51852.5 57776.4 59251.0 59361.1 59376.0 59419.4 13033.5 13166.2 13168.0 13176.5 13177.3 9754.7 10523.9 10604.7 10697.8 11070.1 17434.4 17523.6 17529.7 17556.2 17609.4 6567.6 6622.3 6637.8 6650.2 6825.3 866.3 880.1 967.9 973.3 1048.5 27691.9 28011.9 28567.1 28620.4 28720.9 976.9 1007.8 1043.2 1046.9 1076.7 14615.4 15085.5 15268.2 15305.8 15460.9 311790.0 316054.0 317632.0 318244.0 318702.0 47254.5 48073.3 48082.5 48211.8 48289.3 1075.9 1198.1 1234.3 1253.9 1273.9 24341.5 25632.9 26242.7 26362.3 26388.0 35342.6 36067.6 36194.5 36195.6 36200.0 211592.0 212115.0 212283.0 212380.0 212831.0 22248.1 22994.2 24819.4 25771.4 26041.7 35907.8 35988.3 36007.3 36286.0 37118.6 30260.5 31357.7 32511.5 34206.5 34655.2 33574.0 33625.5 34272.8 34382.3 34505.8 29981.0 30230.0 30420.4 31845.4 34678.7 29624.9 30528.5 30667.7 30700.8 30855.7 23472.2 23657.0 23663.8 24000.9 24305.1 04:38:52 INFO - PROCESS | 4795 | 04:38:52 INFO - PROCESS | 4795 | [#2] jquery.html Cycles:180 Average:23946.11 Median:388.82 stddev:65792.30 (16921.2%) stddev-sans-first:65953.07 04:38:52 INFO - PROCESS | 4795 | Values: 376.5 388.5 389.2 393.1 400.1 15527.4 16911.2 16972.3 17120.7 17152.1 15912.0 16831.4 16868.1 16870.2 16870.4 4895.3 5106.3 5148.5 5174.0 5179.0 3537.2 3801.2 5607.5 5971.9 5981.5 5747.8 5915.6 5920.1 5950.5 5952.8 5694.5 5838.0 5916.3 5927.0 5929.1 3263.6 3504.1 3504.7 3511.2 4907.6 19626.3 20410.9 20450.5 20459.9 20641.7 1862.4 1992.8 2256.1 2511.1 2570.1 12674.4 12896.4 13113.9 13426.8 13658.9 1719.7 1803.8 1832.2 1840.9 1866.3 64345.4 65141.0 65182.7 67063.0 67485.7 9207.5 9279.2 9631.4 9793.0 9809.2 13361.0 13440.3 13468.4 13469.5 13491.1 7055.2 7263.7 7282.7 7297.6 7338.8 6791.3 6855.6 6871.2 6964.9 6969.7 6060.4 6121.3 6147.7 6162.3 6171.3 1620.0 1699.9 1779.4 1789.0 1812.0 831.9 877.9 879.7 892.2 1032.9 15427.5 16087.1 17352.3 17375.0 17624.4 857.9 880.2 907.3 951.8 969.0 9745.6 9928.7 9943.7 9953.3 10056.9 380462.0 403569.0 404209.0 409520.0 409748.0 61620.7 62920.4 64663.7 65275.7 65536.7 951.5 961.5 974.3 975.6 978.1 14943.0 15114.8 15132.8 15381.6 15604.7 29934.6 31024.5 31157.8 31556.5 31900.8 42930.4 42978.0 43016.4 43029.8 43096.0 7694.4 7714.2 7714.5 7715.9 7722.0 11744.2 11757.8 11781.6 11895.7 12007.3 10116.5 10308.0 10388.2 10489.8 10593.9 10606.5 10657.7 10689.4 10721.9 10828.7 10589.3 10784.4 10815.7 10870.5 11062.6 7337.1 7548.1 7557.7 7620.5 7658.0 10811.7 10942.9 11011.4 11023.2 11069.1 04:38:52 INFO - PROCESS | 4795 | 04:38:52 INFO - PROCESS | 4795 | [#3] mootools.html Cycles:180 Average:5273.13 Median:6181.35 stddev:2792.27 (45.2%) stddev-sans-first:2783.87 04:38:52 INFO - PROCESS | 4795 | Values: 1267.9 1461.2 1467.9 1610.7 1786.8 6527.5 7352.1 7593.5 7610.0 7644.8 7276.5 7471.9 7486.5 7487.3 7492.4 1907.7 1948.4 1963.5 2203.9 2244.5 2228.3 2297.4 2298.4 2302.6 2302.6 2190.8 2202.1 2208.8 2210.1 2234.2 2217.3 2218.5 2224.2 2228.5 2232.9 2133.3 2159.5 2159.6 2179.9 2192.7 7588.8 7629.7 7632.0 7643.3 7647.8 4430.2 4576.1 4589.0 4606.5 4631.6 2828.1 2890.9 2916.2 2918.2 2930.1 970.9 1002.8 1011.5 1018.1 1027.5 10067.3 10207.2 10222.9 10314.6 10320.5 4152.6 4158.4 4287.7 4371.7 4396.4 8935.7 8946.0 8956.0 8956.8 8969.0 4565.7 4568.7 4582.4 4604.9 4609.8 3573.3 4092.6 4160.7 4209.5 4238.8 3650.4 3675.3 3724.1 3766.7 3794.6 1213.6 1221.5 1233.1 1236.0 1256.3 891.8 895.1 919.0 919.6 955.9 6796.6 6799.4 6801.5 6804.0 6807.9 453.7 455.7 458.6 459.5 460.0 5608.1 5707.9 5769.0 5769.4 5770.0 8694.4 9041.9 9050.7 9171.0 9193.6 9125.8 9211.4 9248.1 9331.6 9335.9 6909.2 7164.5 7169.2 7174.2 7187.5 7150.1 7208.7 7292.3 7296.6 7306.6 8608.4 8690.1 8800.2 8837.2 8853.9 8750.3 8761.6 9036.3 9143.5 9150.5 5949.1 6087.2 6102.3 6373.6 6473.5 6603.1 7123.8 7272.3 7305.7 7312.3 6429.8 6455.0 6479.0 6527.3 6594.2 6126.7 6240.7 6354.8 6398.5 6486.7 6544.0 6567.9 6602.5 6622.0 6622.3 6101.4 6124.4 6180.6 6182.1 6184.4 6243.3 6256.8 6279.1 6291.3 6310.4 04:38:52 INFO - PROCESS | 4795 | 04:38:52 INFO - PROCESS | 4795 | [#4] prototype.html Cycles:180 Average:4388.38 Median:5023.72 stddev:1275.82 (25.4%) stddev-sans-first:1242.22 04:38:52 INFO - PROCESS | 4795 | Values: 314.8 318.1 320.1 324.3 327.8 4954.6 5043.7 5047.8 5083.0 5083.5 4968.8 4998.1 5005.1 5016.8 5023.1 3762.8 3853.3 3858.2 3973.8 3992.5 3962.0 3977.9 3981.3 3986.3 3989.7 3956.6 3960.6 3962.8 3968.2 3973.8 3696.8 3789.5 3935.4 3956.8 3974.4 3494.2 3524.4 3537.9 3541.8 3545.0 4835.6 4845.9 4853.3 4854.8 4858.4 4194.7 4471.5 4569.0 4569.6 4575.3 5245.8 5262.9 5281.6 5281.9 5282.4 3682.5 3697.8 3707.0 3707.3 3712.3 5396.5 5468.9 5478.8 5533.6 5542.9 3828.8 3832.7 3837.4 3839.3 3840.7 3897.8 3904.1 3904.7 3908.6 3909.3 4398.9 4419.2 4425.4 4433.1 4440.4 5111.2 5265.9 5281.6 5308.5 5314.1 1339.5 1347.6 1354.1 1354.8 1356.4 838.6 887.2 902.5 913.4 924.4 4562.7 4629.6 4629.6 4720.7 4731.9 5464.3 5476.4 5482.2 5482.4 5487.2 4516.9 4714.6 4719.9 4725.4 4729.7 2889.1 2899.2 2915.5 2919.4 2926.6 5135.9 5141.4 5149.0 5149.4 5154.7 5425.0 5470.1 5569.7 5581.7 5607.5 5091.1 5113.0 5131.6 5140.9 5161.5 5433.6 5453.9 5468.9 5477.9 5498.5 5249.0 5344.6 5381.2 5394.0 5421.6 5131.5 5135.7 5158.9 5169.4 5170.6 3762.1 3768.4 3772.8 3777.2 3778.3 5374.6 5470.1 5486.0 5500.1 5506.7 5199.4 5234.2 5249.4 5312.3 5320.5 5286.3 5288.8 5288.9 5291.3 5306.8 5024.3 5195.2 5220.7 5228.6 5235.3 5036.0 5113.8 5298.0 5305.2 5336.9 5220.0 5235.4 5239.3 5244.5 5249.2 04:38:52 INFO - PROCESS | 4795 | 04:38:52 INFO - PROCESS | 4795 | [#5] yui.html Cycles:180 Average:11900.06 Median:3901.61 stddev:12970.97 (332.5%) stddev-sans-first:12980.06 04:38:52 INFO - PROCESS | 4795 | Values: 693.2 709.0 718.9 719.4 729.7 10352.4 10578.4 10609.2 10631.1 10649.8 11224.4 11241.8 11255.1 11255.7 11307.9 631.9 759.8 776.4 786.2 790.2 788.9 790.7 794.4 794.5 795.5 824.0 827.8 828.1 828.8 828.9 649.4 659.6 662.9 817.6 825.8 613.9 616.9 617.1 617.4 617.6 10253.8 10262.6 10265.6 10267.0 10374.8 12137.8 12540.4 12636.4 12820.7 12925.7 10097.8 10138.7 10237.4 10323.9 10362.3 3247.2 3263.7 3267.9 3301.8 3370.5 41095.2 41602.4 46478.5 46566.8 46614.0 9578.4 9662.4 9797.0 10040.7 10199.1 17037.0 17199.5 17258.7 17299.6 17567.1 7020.0 7052.4 7105.6 7148.7 7228.3 3572.4 3596.3 3681.9 3716.3 3735.5 2818.9 2892.3 2898.3 2904.1 2908.3 497.1 513.1 514.3 520.9 521.9 581.8 609.7 641.5 641.8 649.2 7700.0 7845.6 7942.6 7953.6 8206.3 591.9 602.3 604.5 610.8 611.9 3802.4 3873.1 3930.1 3995.8 4035.7 47832.6 48637.5 48675.8 48748.8 48878.0 37371.0 38697.8 42500.6 43438.8 43687.0 31654.2 31709.8 36448.6 36886.1 37779.2 8027.8 8125.4 8462.0 8504.5 8582.2 25100.0 25450.1 25754.9 25825.4 25849.9 32387.2 32463.7 34877.1 35297.8 35813.2 10542.9 10710.7 10780.4 10789.4 10860.9 11953.9 12021.5 12226.1 12612.1 12710.7 10380.1 10695.9 10826.9 10970.1 10993.3 10374.2 10634.5 10638.0 10971.7 11061.1 10186.6 10198.5 10316.0 10526.3 10887.5 9349.1 9523.5 9706.0 9818.6 9843.1 9183.4 9400.3 9741.9 9748.8 9770.4 04:38:52 INFO - PROCESS | 4795 | -------- Summary: end -------- 04:38:52 INFO - PROCESS | 4795 | 04:38:52 INFO - TEST-INFO | 4795: exit 0 04:38:52 INFO - TEST-OK | dromaeo_css | took 1117794ms 04:38:52 INFO - TEST-START | kraken 04:38:52 INFO - operating with platform_type : linux_ 04:38:52 INFO - Initialising browser for kraken test... 04:38:52 INFO - TEST-INFO | started process 4973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpixt71U/profile http://localhost:42756/getInfo.html) 04:38:57 INFO - PROCESS | 4973 | __metrics Screen width/height:1600/1200 04:38:57 INFO - PROCESS | 4973 | colorDepth:24 04:38:57 INFO - PROCESS | 4973 | Browser inner width/height: 1024/697 04:38:57 INFO - PROCESS | 4973 | __metrics 04:38:58 ERROR - PROCESS | 4973 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:38:58 INFO - TEST-INFO | 4973: exit 0 04:38:58 INFO - Browser initialized. 04:38:58 INFO - Running cycle 1/1 for kraken test... 04:38:58 INFO - TEST-INFO | started process 5053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpixt71U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:39:10 INFO - PROCESS | 5053 | RSS: Main: 154206208 04:39:10 INFO - PROCESS | 5053 | 04:39:13 INFO - PROCESS | 5053 | Cycle 1(1): loaded http://localhost:42756/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42756/tests/kraken/driver.html?testName=audio-beat-detection) 04:39:14 INFO - PROCESS | 5053 | RSS: Main: 196186112 04:39:14 INFO - PROCESS | 5053 | 04:39:16 INFO - PROCESS | 5053 | Cycle 1(1): loaded http://localhost:42756/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42756/tests/kraken/driver.html?testName=audio-dft) 04:39:17 INFO - PROCESS | 5053 | RSS: Main: 186503168 04:39:17 INFO - PROCESS | 5053 | 04:39:20 INFO - PROCESS | 5053 | Cycle 1(1): loaded http://localhost:42756/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42756/tests/kraken/driver.html?testName=audio-fft) 04:39:21 INFO - PROCESS | 5053 | RSS: Main: 169619456 04:39:21 INFO - PROCESS | 5053 | 04:39:23 INFO - PROCESS | 5053 | Cycle 1(1): loaded http://localhost:42756/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42756/tests/kraken/driver.html?testName=audio-oscillator) 04:39:23 INFO - PROCESS | 5053 | RSS: Main: 171954176 04:39:23 INFO - PROCESS | 5053 | 04:39:26 INFO - PROCESS | 5053 | Cycle 1(1): loaded http://localhost:42756/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42756/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:39:26 INFO - PROCESS | 5053 | RSS: Main: 173182976 04:39:26 INFO - PROCESS | 5053 | 04:39:29 INFO - PROCESS | 5053 | Cycle 1(1): loaded http://localhost:42756/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42756/tests/kraken/driver.html?testName=imaging-darkroom) 04:39:30 INFO - PROCESS | 5053 | RSS: Main: 173527040 04:39:30 INFO - PROCESS | 5053 | 04:39:33 INFO - PROCESS | 5053 | Cycle 1(1): loaded http://localhost:42756/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42756/tests/kraken/driver.html?testName=imaging-desaturate) 04:39:34 INFO - PROCESS | 5053 | RSS: Main: 174686208 04:39:34 INFO - PROCESS | 5053 | 04:39:37 INFO - PROCESS | 5053 | Cycle 1(1): loaded http://localhost:42756/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42756/tests/kraken/driver.html?testName=json-parse-financial) 04:39:37 INFO - PROCESS | 5053 | RSS: Main: 174292992 04:39:37 INFO - PROCESS | 5053 | 04:39:39 INFO - PROCESS | 5053 | Cycle 1(1): loaded http://localhost:42756/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42756/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:39:40 INFO - PROCESS | 5053 | RSS: Main: 184250368 04:39:40 INFO - PROCESS | 5053 | 04:39:42 INFO - PROCESS | 5053 | Cycle 1(1): loaded http://localhost:42756/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42756/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:39:42 INFO - PROCESS | 5053 | RSS: Main: 182730752 04:39:42 INFO - PROCESS | 5053 | 04:39:44 INFO - PROCESS | 5053 | Cycle 1(1): loaded http://localhost:42756/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42756/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:39:45 INFO - PROCESS | 5053 | RSS: Main: 193916928 04:39:45 INFO - PROCESS | 5053 | 04:39:48 INFO - PROCESS | 5053 | Cycle 1(1): loaded http://localhost:42756/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42756/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:39:48 INFO - PROCESS | 5053 | RSS: Main: 199753728 04:39:48 INFO - PROCESS | 5053 | 04:39:51 INFO - PROCESS | 5053 | Cycle 1(1): loaded http://localhost:42756/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42756/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:39:52 INFO - PROCESS | 5053 | RSS: Main: 199819264 04:39:52 INFO - PROCESS | 5053 | 04:39:54 INFO - PROCESS | 5053 | Cycle 1(1): loaded http://localhost:42756/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42756/tests/kraken/driver.html?testName=ai-astar) 04:39:54 INFO - PROCESS | 5053 | RSS: Main: 262684672 04:39:54 INFO - PROCESS | 5053 | 04:39:54 INFO - PROCESS | 5053 | __start_tp_report 04:39:54 INFO - PROCESS | 5053 | _x_x_mozilla_page_load 04:39:54 INFO - PROCESS | 5053 | _x_x_mozilla_page_load_details 04:39:54 INFO - PROCESS | 5053 | |i|pagename|runs| 04:39:54 INFO - PROCESS | 5053 | |0;ai-astar;114;114;108;113;116;115;102;114;114;114 04:39:54 INFO - PROCESS | 5053 | |1;audio-beat-detection;157;132;154;191;140;160;159;137;176;133 04:39:54 INFO - PROCESS | 5053 | |2;audio-dft;161;162;162;163;162;159;161;161;161;161 04:39:54 INFO - PROCESS | 5053 | |3;audio-fft;74;73;107;96;78;73;75;126;100;74 04:39:54 INFO - PROCESS | 5053 | |4;audio-oscillator;94;93;144;93;94;93;160;92;93;137 04:39:54 INFO - PROCESS | 5053 | |5;imaging-gaussian-blur;117;116;116;116;117;117;117;117;117;117 04:39:54 INFO - PROCESS | 5053 | |6;imaging-darkroom;148;148;148;147;147;147;146;145;148;146 04:39:54 INFO - PROCESS | 5053 | |7;imaging-desaturate;96;96;96;95;95;95;95;96;95;95 04:39:54 INFO - PROCESS | 5053 | |8;json-parse-financial;66;67;68;66;68;67;66;74;64;64 04:39:54 INFO - PROCESS | 5053 | |9;json-stringify-tinderbox;65;65;65;63;64;64;65;65;66;64 04:39:54 INFO - PROCESS | 5053 | |10;stanford-crypto-aes;83;90;91;84;83;94;84;86;85;84 04:39:54 INFO - PROCESS | 5053 | |11;stanford-crypto-ccm;140;139;141;138;136;139;146;139;138;142 04:39:54 INFO - PROCESS | 5053 | |12;stanford-crypto-pbkdf2;175;175;181;174;175;174;178;179;176;181 04:39:54 INFO - PROCESS | 5053 | |13;stanford-crypto-sha256-iterative;70;81;81;71;69;70;70;72;70;68 04:39:54 INFO - PROCESS | 5053 | __end_tp_report 04:39:54 INFO - PROCESS | 5053 | __start_cc_report 04:39:54 INFO - PROCESS | 5053 | _x_x_mozilla_cycle_collect,1168 04:39:54 INFO - PROCESS | 5053 | __end_cc_report 04:39:54 INFO - PROCESS | 5053 | __startTimestamp1460115594314__endTimestamp 04:39:54 INFO - PROCESS | 5053 | 04:39:54 INFO - PROCESS | 5053 | ------- Summary: start ------- 04:39:54 INFO - PROCESS | 5053 | Number of tests: 14 04:39:54 INFO - PROCESS | 5053 | 04:39:54 INFO - PROCESS | 5053 | [#0] ai-astar Cycles:10 Average:112.40 Median:114.00 stddev:4.22 (3.7%) stddev-sans-first:4.44 04:39:54 INFO - PROCESS | 5053 | Values: 114.0 114.0 108.0 113.0 116.0 115.0 102.0 114.0 114.0 114.0 04:39:54 INFO - PROCESS | 5053 | 04:39:54 INFO - PROCESS | 5053 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:158.00 stddev:19.24 (12.2%) stddev-sans-first:20.38 04:39:54 INFO - PROCESS | 5053 | Values: 157.0 132.0 154.0 191.0 140.0 160.0 159.0 137.0 176.0 133.0 04:39:54 INFO - PROCESS | 5053 | 04:39:54 INFO - PROCESS | 5053 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.06 (0.7%) stddev-sans-first:1.12 04:39:54 INFO - PROCESS | 5053 | Values: 161.0 162.0 162.0 163.0 162.0 159.0 161.0 161.0 161.0 161.0 04:39:54 INFO - PROCESS | 5053 | 04:39:54 INFO - PROCESS | 5053 | [#3] audio-fft Cycles:10 Average:87.60 Median:74.00 stddev:18.63 (25.2%) stddev-sans-first:19.09 04:39:54 INFO - PROCESS | 5053 | Values: 74.0 73.0 107.0 96.0 78.0 73.0 75.0 126.0 100.0 74.0 04:39:54 INFO - PROCESS | 5053 | 04:39:54 INFO - PROCESS | 5053 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:93.00 stddev:26.61 (28.6%) stddev-sans-first:27.64 04:39:54 INFO - PROCESS | 5053 | Values: 94.0 93.0 144.0 93.0 94.0 93.0 160.0 92.0 93.0 137.0 04:39:54 INFO - PROCESS | 5053 | 04:39:54 INFO - PROCESS | 5053 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:39:54 INFO - PROCESS | 5053 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 04:39:54 INFO - PROCESS | 5053 | 04:39:54 INFO - PROCESS | 5053 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.50 stddev:1.05 (0.7%) stddev-sans-first:1.05 04:39:54 INFO - PROCESS | 5053 | Values: 148.0 148.0 148.0 147.0 147.0 147.0 146.0 145.0 148.0 146.0 04:39:54 INFO - PROCESS | 5053 | 04:39:54 INFO - PROCESS | 5053 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:39:54 INFO - PROCESS | 5053 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 04:39:54 INFO - PROCESS | 5053 | 04:39:54 INFO - PROCESS | 5053 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:67.00 stddev:2.83 (4.2%) stddev-sans-first:2.98 04:39:54 INFO - PROCESS | 5053 | Values: 66.0 67.0 68.0 66.0 68.0 67.0 66.0 74.0 64.0 64.0 04:39:54 INFO - PROCESS | 5053 | 04:39:54 INFO - PROCESS | 5053 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 04:39:54 INFO - PROCESS | 5053 | Values: 65.0 65.0 65.0 63.0 64.0 64.0 65.0 65.0 66.0 64.0 04:39:54 INFO - PROCESS | 5053 | 04:39:54 INFO - PROCESS | 5053 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:85.50 stddev:3.86 (4.5%) stddev-sans-first:3.90 04:39:54 INFO - PROCESS | 5053 | Values: 83.0 90.0 91.0 84.0 83.0 94.0 84.0 86.0 85.0 84.0 04:39:54 INFO - PROCESS | 5053 | 04:39:54 INFO - PROCESS | 5053 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:139.50 stddev:2.74 (2.0%) stddev-sans-first:2.91 04:39:54 INFO - PROCESS | 5053 | Values: 140.0 139.0 141.0 138.0 136.0 139.0 146.0 139.0 138.0 142.0 04:39:54 INFO - PROCESS | 5053 | 04:39:54 INFO - PROCESS | 5053 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:177.00 stddev:2.74 (1.5%) stddev-sans-first:2.83 04:39:54 INFO - PROCESS | 5053 | Values: 175.0 175.0 181.0 174.0 175.0 174.0 178.0 179.0 176.0 181.0 04:39:54 INFO - PROCESS | 5053 | 04:39:54 INFO - PROCESS | 5053 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:70.50 stddev:4.76 (6.7%) stddev-sans-first:4.98 04:39:54 INFO - PROCESS | 5053 | Values: 70.0 81.0 81.0 71.0 69.0 70.0 70.0 72.0 70.0 68.0 04:39:54 INFO - PROCESS | 5053 | -------- Summary: end -------- 04:39:54 INFO - PROCESS | 5053 | 04:39:55 INFO - TEST-INFO | 5053: exit 0 04:39:55 INFO - TEST-OK | kraken | took 62576ms 04:39:55 INFO - SUITE-END | took 1180s 04:39:55 INFO - Completed test suite (00:19:40) 04:39:55 INFO - javascript benchmark 04:39:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2576.587745960646, 2641.115226399156, 2659.4681063787248, 2683.6377089092966, 2696.608991696204, 4503.932441013388, 4504.436945381827, 4520.0, 4566.31505274209, 4576.016156526346, 4500.504944456107, 4526.411566496359, 4568.063546972871, 4569.6801223914335, 4601.010782681723, 4164.10471748574, 4181.435506206662, 4213.0520632857515, 4246.893827654318, 4330.631896288819, 4281.058167203226, 4288.528261891205, 4299.484061912559, 4319.157764235975, 4342.5874541918465, 4129.112240868198, 4141.316682747343, 4212.241796476633, 4214.599613036757, 4218.367244913257, 4233.407322974786, 4235.428217190671, 4241.0, 4277.508086570022, 4277.871663850058, 4206.789660516962, 4216.894577635584, 4236.04688944988, 4242.469691288589, 4259.744415335059, 4396.582324679151, 4448.666350023761, 4532.546745325474, 4533.863984080483, 4535.070310586322, 4861.586765124968, 4878.902421951577, 4879.365682461293, 4882.0, 4909.705417674951, 4896.730679812609, 4902.534259245366, 4903.632227582945, 4912.680675756064, 4953.876153096166, 4508.323751437278, 4564.771761411983, 4571.1771881061395, 4652.767361631905, 4663.860084197479, 5006.874828129253, 5030.2957585938, 5032.647714660012, 5036.471170527115, 5064.240363945364, 4833.734144622009, 4836.661433699607, 4838.274258861128, 4840.177169881129, 4880.41435027799, 4787.952120478821, 4887.780049897763, 4961.627877909099, 4988.426330971912, 4990.151674215392, 4854.83008094715, 4858.44127925286, 4866.586340161055, 4875.804967801319, 4928.778204980785, 4852.1508735971065, 4856.1987272099705, 4856.465788763233, 4859.708417494961, 4909.975450122726, 4075.5109386873173, 4098.098418347959, 4099.385092236129, 4156.314208155621, 4178.101708132766, 3622.746407751432, 3642.508261384732, 3643.3259846928404, 3662.5788034375855, 3681.5950245472977, 4267.466566679165, 4276.743395396286, 4279.550647182001, 4283.357496375568, 4325.24308246062, 4789.760511974388, 4844.0554091951735, 4891.902161956812, 4927.802887884516, 4938.160512712848, 4232.809523571446, 4235.449391579136, 4245.490541135022, 4246.384274280212, 4286.185624731291, 4331.112122014979, 4367.497737760134, 4405.581469760367, 4443.244648409778, 4449.9777501112285, 4620.168369693421, 4657.767111644472, 4659.60393366554, 4704.05918816245, 4705.505921878222, 4883.60931125502, 4888.413390393175, 4897.755112244445, 4899.877503062309, 4922.606191504743, 4543.204939135704, 4606.884827879196, 4610.054938737484, 4612.815487380467, 4664.370310008106, 4799.112164249625, 4813.0, 4820.71075735457, 4848.75756212195, 4868.14807408695, 4842.58837998774, 4878.56092951636, 4878.780454879468, 4886.9022619546695, 4931.852044438672, 4637.675362724577, 4691.5308469152815, 4746.92879606813, 4751.976240118777, 4792.856214313576, 4790.161721698619, 4802.087603355351, 4807.879803004953, 4826.420829500483, 4857.149998750134, 4723.45680246776, 4724.706630182603, 4725.054989002145, 4727.267273572602, 4784.880377990578, 4656.580907718321, 4711.057788442256, 4723.763811809465, 4804.735739534359, 4821.397325334333, 4671.556202160789, 4712.717236965793, 4713.481517033192, 4734.360861283682, 4749.738764367993], "value": 4504.93269440159, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.9377468478467, 586.7799575159314, 616.223558316521, 620.4663988969488, 629.4115002472691, 25991.740082599194, 33015.33969320612, 33769.49345759815, 33857.153571160736, 33982.49026264608, 36590.45114323281, 37305.62694373055, 37416.812915935385, 37438.25123497535, 37475.0, 7531.811704707371, 7706.576138312391, 7714.575698336589, 7715.151333353327, 7718.151003389623, 7565.35694465971, 7659.961700191491, 7663.69345226193, 7670.808229794272, 7676.501027433227, 7663.846723065535, 7861.921380786176, 7864.488808227476, 7868.685252589889, 7877.291043806056, 7796.298333150015, 7854.764357069297, 7855.607219638995, 7862.488938218998, 7865.567393793339, 7685.500442471277, 7797.649105790253, 7801.375889928792, 7811.257930496594, 7812.0, 37038.0, 37450.25099498022, 37552.0, 37554.81222593897, 37603.43594846079, 2931.2525306047037, 3076.107928700674, 3083.090488305933, 3114.797538160012, 3163.7785355025158, 27870.721292787017, 27983.160505184675, 28118.718812811814, 29101.854490727623, 29232.123036308945, 3451.8274086295837, 3463.3765922134007, 3473.9652603473896, 3483.372992861284, 3510.4383298672346, 330937.0, 341840.0, 342466.0, 343351.0, 343522.0, 48104.27843582279, 51311.0, 51647.48352516502, 51727.22409163866, 51852.481475184766, 57776.42223577711, 59251.0, 59361.10958335629, 59376.0, 59419.40580594139, 13033.543825966046, 13166.210027398387, 13168.0, 13176.47294108225, 13177.341132943315, 9754.707358779247, 10523.94738026305, 10604.681859544226, 10697.83953240702, 11070.114390848712, 17434.389796357067, 17523.649527009387, 17529.7370539442, 17556.2099705511, 17609.38367157169, 6567.573107747981, 6622.337766223339, 6637.834054148685, 6650.168728908887, 6825.317468253135, 866.328595338605, 880.126387345318, 967.9128878400978, 973.3332667123043, 1048.4810019040624, 27691.86154069257, 28011.859940700167, 28567.142985710463, 28620.427591448053, 28720.856395718307, 976.8876579193342, 1007.8185926533148, 1043.1915265669168, 1046.9162467002623, 1076.7469644633504, 14615.415383384545, 15085.47200847965, 15268.16025118607, 15305.846941530443, 15460.92269538645, 311790.0, 316054.0, 317632.0, 318244.0, 318702.0, 47254.5274547257, 48073.27890081651, 48082.51917480781, 48211.75894120507, 48289.27566086512, 1075.8547596074586, 1198.1313547678037, 1234.3211233821362, 1253.899688024974, 1273.8598754137038, 24341.480481831924, 25632.8718356407, 26242.737572624028, 26362.34094147585, 26388.0, 35342.64657353394, 36067.639323606425, 36194.4570831443, 36195.63804361923, 36200.0, 211592.0, 212115.0, 212283.0, 212380.0, 212831.0, 22248.110075597444, 22994.19520316781, 24819.379515512257, 25771.355716107246, 26041.73958260469, 35907.82046089753, 35988.28023439569, 36007.279854402244, 36286.0, 37118.62881371152, 30260.5460918082, 31357.686423135478, 32511.512327314635, 34206.48690269598, 34655.18792932725, 33574.0, 33625.495617566245, 34272.82863585766, 34382.312353752284, 34505.82747086249, 29980.95066672656, 30230.0, 30420.391592168475, 31845.36309273848, 34678.65321346754, 29624.85187574048, 30528.542071868495, 30667.693323067375, 30700.84649576738, 30855.69144308528, 23472.178473753338, 23656.97584526617, 23663.763362366157, 24000.87999559991, 24305.14931977372], "value": 16802.89954324146, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.5075202161689, 388.469738806529, 389.16135727507213, 393.08019234990115, 400.0937875711512, 15527.378904843807, 16911.154442277897, 16972.321107155716, 17120.657586848254, 17152.142392880367, 15912.0, 16831.41090061848, 16868.072256025913, 16870.240839162238, 16870.409535666255, 4895.339129217546, 5106.259592359106, 5148.536631703146, 5174.016936782018, 5179.041877252702, 3537.168765340156, 3801.2397520495874, 5607.523360514361, 5971.940280597182, 5981.491573216282, 5747.770089196448, 5915.615484993483, 5920.052791553352, 5950.464458198761, 5952.8214153575245, 5694.5159661428825, 5838.007538718428, 5916.26046744157, 5926.970365148169, 5929.080992446156, 3263.6083669959758, 3504.1414853360834, 3504.737144714157, 3511.20997775501, 4907.631927605408, 19626.313079042164, 20410.897945510325, 20450.488737781525, 20459.897700511552, 20641.690374644393, 1862.3854128137818, 1992.7733504924981, 2256.0975609756065, 2511.1336588876807, 2570.0876188953025, 12674.36628168597, 12896.419661115273, 13113.934430327883, 13426.798598021038, 13658.931705341509, 1719.6904557179703, 1803.7655104836288, 1832.239620557467, 1840.8527317814542, 1866.2721538599958, 64345.35654643441, 65141.0, 65182.67408662974, 67062.9940550897, 67485.66257168732, 9207.539623018956, 9279.164875161268, 9631.422114673142, 9792.951035244778, 9809.19349518745, 13361.0, 13440.260785656883, 13468.39392227352, 13469.461221551224, 13491.055626106274, 7055.2239253682055, 7263.709451621981, 7282.672279747424, 7297.635118244173, 7338.816529586697, 6791.252962174157, 6855.5543889647015, 6871.175458944958, 6964.94534112438, 6969.721211151598, 6060.424289684625, 6121.296050954197, 6147.72335244915, 6162.291336496361, 6171.321154672983, 1619.9757003644954, 1699.9320027199021, 1779.3861117914557, 1788.9552761181073, 1812.0, 831.9126491718404, 877.9078196789372, 879.6613303878053, 892.2282225874701, 1032.9070383665505, 15427.46003889881, 16087.115208663636, 17352.3059077638, 17374.95750254989, 17624.383146590066, 857.9356548258905, 880.2210044111008, 907.3467103685336, 951.8381875081253, 969.0, 9745.56144973478, 9928.702138935843, 9943.651972181084, 9953.303268771262, 10056.899431005742, 380462.0, 403569.0, 404209.0, 409520.0, 409748.0, 61620.69189654023, 62920.37079629145, 64663.67668161629, 65275.67362163159, 65536.67231663811, 951.4814426137772, 961.5192403798101, 974.3471873844542, 975.5561219644902, 978.0708327089294, 14943.0, 15114.848851511784, 15132.848671513584, 15381.615459613598, 15604.68790624204, 29934.550981734857, 31024.53463198099, 31157.8442107788, 31556.52665209978, 31900.840495797373, 42930.35604465873, 42978.0, 43016.354754678076, 43029.78485107554, 43096.0, 7694.422918281263, 7714.190010048864, 7714.4599878008, 7715.884261735966, 7721.996140501924, 11744.236624619372, 11757.823632645688, 11781.587644432404, 11895.702607434538, 12007.279563226235, 10116.544755485873, 10308.036825080866, 10388.168946484415, 10489.842652360374, 10593.947030265108, 10606.522706478072, 10657.680269591925, 10689.412082335235, 10721.946390267998, 10828.675139745821, 10589.311694739818, 10784.352938823695, 10815.669759033764, 10870.510827012646, 11062.612808551663, 7337.119545654556, 7548.094228692592, 7557.735479258419, 7620.542767433972, 7658.0, 10811.675649730521, 10942.945285273523, 11011.394373309224, 11023.228374013743, 11069.114470842153], "value": 8277.657149672654, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1267.8732126787318, 1461.1671347332026, 1467.8605532474414, 1610.6537094524674, 1786.7677201963743, 6527.510436717242, 7352.117745870496, 7593.544387336757, 7609.961950190255, 7644.808879778008, 7276.527025743323, 7471.887921681179, 7486.47594668372, 7487.288707572786, 7492.363149132317, 1907.7138429235588, 1948.4154753573941, 1963.5483838717103, 2203.8787866667326, 2244.517428752818, 2228.253535065755, 2297.414159389362, 2298.367948814073, 2302.5625131225097, 2302.643090321003, 2190.8247340212743, 2202.1081462007833, 2208.8232941364654, 2210.1159536185573, 2234.20685656592, 2217.2793842001333, 2218.545198234358, 2224.165937773335, 2228.543148654522, 2232.8771917544527, 2133.3173384516963, 2159.492519257973, 2159.6436587962967, 2179.8692078475183, 2192.6930229767845, 7588.810279742996, 7629.6948122075055, 7631.961840190819, 7643.312101910799, 7647.770566883002, 4430.180416622935, 4576.061907308994, 4589.036302376505, 4606.516315786827, 4631.60631346336, 2828.0808737160505, 2890.927726806826, 2916.1834686287875, 2918.1974956886816, 2930.0623800383887, 970.9029097090305, 1002.8144793213279, 1011.4942528735633, 1018.0989824005734, 1027.547878933267, 10067.345622534513, 10207.234457415723, 10222.948885255526, 10314.638987635471, 10320.483975801255, 4152.563980782034, 4158.37624356349, 4287.742735435884, 4371.715838470489, 4396.362527433568, 8935.731928042169, 8946.0, 8956.0, 8956.776080597907, 8968.955155224183, 4565.703229290086, 4568.70303430276, 4582.381378513925, 4604.884877878013, 4609.792559334838, 3573.321068996934, 4092.570280120604, 4160.687948403882, 4209.473815773028, 4238.809253583596, 3650.4341827016856, 3675.2833197526224, 3724.0689827543115, 3766.6986641068647, 3794.628357276702, 1213.5558685164626, 1221.5358163897663, 1233.1429656388723, 1236.0358920042381, 1256.309030033478, 891.7592250092439, 895.0914821456228, 918.995405022984, 919.6367434863191, 955.8709574207533, 6796.592204467748, 6799.388055075067, 6801.4558835293055, 6804.047433359334, 6807.863842723118, 453.7322979442145, 455.73339596335853, 458.6147635985788, 459.4509561074484, 460.03620930163163, 5608.074667679787, 5707.914381284284, 5769.048107062372, 5769.394213607511, 5770.0, 8694.434861733967, 9041.90958090424, 9050.683226087187, 9171.0, 9193.586288617029, 9125.771855703528, 9211.355205135711, 9248.075192480832, 9331.626734930527, 9335.94609185978, 6909.170899492093, 7164.534305270141, 7169.211386747454, 7174.174969878531, 7187.496875218684, 7150.141982962078, 7208.747693830691, 7292.307230813064, 7296.598687072262, 7306.561606303639, 8608.397412181088, 8690.087540808125, 8800.16398442147, 8837.232553489199, 8853.911460885309, 8750.343724220582, 8761.605727742139, 9036.277097832026, 9143.542822858963, 9150.49672268005, 5949.107633854784, 6087.239095113111, 6102.298235702773, 6373.649449280334, 6473.482121430368, 6603.075569420381, 7123.786286411416, 7272.272772722686, 7305.744298949511, 7312.341889229995, 6429.7749578764515, 6455.0, 6478.967605161944, 6527.336966285391, 6594.208694956636, 6126.724297406538, 6240.687965601611, 6354.841128971812, 6398.5201109916015, 6486.740530378732, 6544.0, 6567.868642627025, 6602.471802255712, 6622.0, 6622.337766223339, 6101.38986101404, 6124.418180272867, 6180.6291622502795, 6182.072689096672, 6184.443400094013, 6243.250809902659, 6256.843578910563, 6279.089532017923, 6291.307956124914, 6310.400511951358], "value": 4232.204884141085, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.7592092049581, 318.11722470145344, 320.143615827661, 324.2525977621584, 327.8328052693126, 4954.6284028697855, 5043.672161309517, 5047.77285022174, 5082.974585127078, 5083.466236045213, 4968.776405061772, 4998.10034193845, 5005.0990821652085, 5016.8494945151615, 5023.120953833074, 3762.7930463824478, 3853.287141878747, 3858.2090671412293, 3973.801309934506, 3992.4809774729247, 3961.9603803962023, 3977.86077487288, 3981.343078392076, 3986.3422535281643, 3989.68082553395, 3956.5845586213463, 3960.603939606031, 3962.762234265939, 3968.2063587282514, 3973.8211780469946, 3696.7781933083834, 3789.488419063419, 3935.4096885467125, 3956.7625942443547, 3974.423708562242, 3494.2312691207894, 3524.436090225577, 3537.9469307960403, 3541.8394779184678, 3544.964550354515, 4835.6131509479155, 4845.903081938377, 4853.272009198648, 4854.805807767685, 4858.416989961227, 4194.748315101073, 4471.463424389061, 4568.977155114237, 4569.611583015414, 4575.336576196466, 5245.79016839326, 5262.9474105179115, 5281.551068159211, 5281.947180528184, 5282.445343238943, 3682.502862113634, 3697.759645623026, 3707.0158522389465, 3707.2751527627174, 3712.3132220539287, 5396.541293990015, 5468.945310546884, 5478.753456094445, 5533.584981126432, 5542.91685624716, 3828.770273783582, 3832.674222691047, 3837.4052021936645, 3839.347310957144, 3840.6543411093135, 3897.7661340319673, 3904.1020565270146, 3904.668103211202, 3908.5700572936953, 3909.257241124177, 4398.934015989763, 4419.226635338867, 4425.424694789721, 4433.135538569948, 4440.4227450431235, 5111.156659151273, 5265.921011184835, 5281.551068159172, 5308.495692909168, 5314.12316967696, 1339.504383378137, 1347.5822495026573, 1354.0927578522414, 1354.8306461692289, 1356.4438580182077, 838.6351936907465, 887.1749273176008, 902.5081330674798, 913.410665442126, 924.4268553496875, 4562.703424277412, 4629.560191781776, 4629.629629629689, 4720.669553131316, 4731.929021064687, 5464.316960379952, 5476.424975377608, 5482.205080263419, 5482.424345443751, 5487.2317875497465, 4516.88707782308, 4714.599259062949, 4719.882002949885, 4725.362076119749, 4729.739864307496, 2889.1188187602984, 2899.1882272963603, 2915.4606397816474, 2919.4163165598598, 2926.634170728659, 5135.871603209875, 5141.3830340358645, 5148.9742551287, 5149.356330458692, 5154.742262886915, 5424.972875135599, 5470.073682966213, 5569.693666848281, 5581.6930068846605, 5607.523360514402, 5091.1090559152, 5113.0, 5131.61512886535, 5140.922886156711, 5161.535461808456, 5433.592480563894, 5453.863653408538, 5468.863278418072, 5477.863053423696, 5498.532624726943, 5248.9737551312, 5344.625876188629, 5381.165919282517, 5394.0, 5421.620486565903, 5131.461196574306, 5135.737338009369, 5158.948410515847, 5169.405518365285, 5170.560502357342, 3762.0655888407086, 3768.3970564709516, 3772.7924964127237, 3777.2445510897383, 3778.3387907115593, 5374.570034397317, 5470.097433923358, 5486.0, 5500.092484740133, 5506.697131657797, 5199.376074871039, 5234.18870075139, 5249.4225635180865, 5312.309399778004, 5320.494553017457, 5286.312779338661, 5288.8413347599635, 5288.920666190087, 5291.3385826771655, 5306.787728490972, 5024.321716568216, 5195.246689230116, 5220.686758794484, 5228.555572776357, 5235.293235413171, 5036.0, 5113.846584602468, 5297.973510132425, 5305.1776974569, 5336.946630533645, 5219.973900130475, 5235.397929238034, 5239.345081864767, 5244.501772331622, 5249.160134378634], "value": 3985.207880741284, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.1716598664597, 708.950373473857, 718.8526352097819, 719.4460265595492, 729.6643543969774, 10352.378857268559, 10578.36529808212, 10609.204309676767, 10631.09635680967, 10649.763549654572, 11224.382658953755, 11241.83137252942, 11255.099592032639, 11255.718607034829, 11307.943460282688, 631.8831016261984, 759.8252401947556, 776.4332037612546, 786.2294950948075, 790.2374208888422, 788.9289963903248, 790.7074382478492, 794.4359504751633, 794.4796158516181, 795.5147360110328, 824.044108833753, 827.8385714785619, 828.1345993436843, 828.8093738440162, 828.8756686497013, 649.3895738006306, 659.5515049766133, 662.8574856405871, 817.6075483767825, 825.7605294464598, 613.9109829074804, 616.929053158888, 617.062065660194, 617.3517806303364, 617.6109051297653, 10253.79543398173, 10262.589496420134, 10265.589376424934, 10267.0, 10374.844377334346, 12137.817932730928, 12540.435680394405, 12636.368181590884, 12820.743585128244, 12925.741485170338, 10097.798044039078, 10138.746531336701, 10237.385756854537, 10323.896761032443, 10362.27464077515, 3247.236899328656, 3263.6573159818354, 3267.9019629411155, 3301.834908254578, 3370.4944258361197, 41095.17809643791, 41602.37596436056, 46478.53521464776, 46566.76716616429, 46614.0, 9578.425294482353, 9662.420254784736, 9797.0, 10040.748981275381, 10199.082082612453, 17037.0, 17199.484015479306, 17258.654826903392, 17299.56751081233, 17567.12164391775, 7020.0, 7052.400545953549, 7105.644717764091, 7148.749793757193, 7228.349448549656, 3572.374834403969, 3596.3346780845104, 3681.889543313705, 3716.331060409152, 3735.533058367704, 2818.8872445101965, 2892.305846596844, 2898.347871728844, 2904.0852131578486, 2908.34562223498, 497.1101727907078, 513.0662194805418, 514.3005512502993, 520.9036328279204, 521.9451957544479, 581.7876475086648, 609.7073404765737, 641.4868105515569, 641.8267067891643, 649.1949982022353, 7699.961500192463, 7845.568493732785, 7942.6425810838655, 7953.625505971692, 8206.302464290602, 591.9052951527735, 602.3193791016124, 604.5345084285076, 610.8228613702065, 611.9357467465941, 3802.372608519563, 3873.1479074603544, 3930.0764320384687, 3995.780232087205, 4035.6771458283856, 47832.618775486284, 48637.513624864005, 48675.75662121738, 48748.75625621849, 48878.0, 37371.0, 38697.80651096783, 42500.57499425028, 43438.782806085765, 43687.0, 31654.208644783605, 31709.8414507926, 36448.63551364505, 36886.07784805348, 37779.24441511154, 8027.799305017421, 8125.432693984033, 8462.0, 8504.53225072627, 8582.227599516074, 25100.0, 25450.109246177035, 25754.87122564375, 25825.354366140997, 25849.870750646878, 32387.19032024218, 32463.675363246064, 34877.128071798405, 35297.823510882285, 35813.2093395324, 10542.894571054192, 10710.678679639623, 10780.353178809297, 10789.352638841694, 10860.945695271474, 11953.880461195276, 12021.45903434365, 12226.14416990802, 12612.054095942658, 12710.682232944251, 10380.117689996132, 10695.89304106949, 10826.89173108259, 10970.122390208924, 10993.340399576051, 10374.221933354878, 10634.468276586294, 10638.0, 10971.725706857393, 11061.115110790957, 10186.643467478603, 10198.490075496344, 10316.0, 10526.263161578921, 10887.510062047386, 9349.111834375723, 9523.476208808304, 9705.951470242886, 9818.558164882741, 9843.114119729258, 9183.403078799856, 9400.294977876823, 9741.9025809741, 9748.756281093029, 9770.413775173512], "value": 5740.891138250838, "unit": "score"}], "name": "dromaeo_css", "value": 6268.59965798691, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 108.0, 113.0, 116.0, 115.0, 102.0, 114.0, 114.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 132.0, 154.0, 191.0, 140.0, 160.0, 159.0, 137.0, 176.0, 133.0], "value": 153.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 162.0, 159.0, 161.0, 161.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 107.0, 96.0, 78.0, 73.0, 75.0, 126.0, 100.0, 74.0], "value": 87.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 144.0, 93.0, 94.0, 93.0, 160.0, 92.0, 93.0, 137.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 146.0, 145.0, 148.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 66.0, 68.0, 67.0, 66.0, 74.0, 64.0, 64.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 63.0, 64.0, 64.0, 65.0, 65.0, 66.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 90.0, 91.0, 84.0, 83.0, 94.0, 84.0, 86.0, 85.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 141.0, 138.0, 136.0, 139.0, 146.0, 139.0, 138.0, 142.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 181.0, 174.0, 175.0, 174.0, 178.0, 179.0, 176.0, 181.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 81.0, 81.0, 71.0, 69.0, 70.0, 70.0, 72.0, 70.0, 68.0], "value": 72.2, "unit": "score"}], "name": "kraken", "value": 1590.3999999999999, "alertThreshold": 2.0}]} 04:39:55 INFO - Return code: 0 04:39:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:39:55 ERROR - # TBPL SUCCESS # 04:39:55 INFO - Running post-action listener: _resource_record_post_action 04:39:55 INFO - Running post-run listener: _resource_record_post_run 04:39:56 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518705152; Read time: 8; Write time: 510368 04:39:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233402368; Read time: 0; Write time: 295596 04:39:56 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285302784; Read time: 8; Write time: 214772 04:39:56 INFO - Running post-run listener: _upload_blobber_files 04:39:56 INFO - Blob upload gear active. 04:39:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:39:56 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 04:39:56 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'] 04:39:56 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 04:39:57 INFO - (blobuploader) - INFO - Open directory for files ... 04:39:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:39:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:39:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:58 INFO - (blobuploader) - INFO - Done attempting. 04:39:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:39:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:39:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:59 INFO - (blobuploader) - INFO - Done attempting. 04:39:59 INFO - (blobuploader) - INFO - Iteration through files over. 04:39:59 INFO - Return code: 0 04:39:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:39:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:39:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b318dee2595cd071128ca943e005e178fc4f4a8af4e364fd2eee0c4a7a1780680f7279cb06421f1650061c728ee40c79f6985701cf8b9cca53d5bfb4a4dd68d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/03e04cd8e3a6de54ca69c0332587bf5287deb05bc714161d18f1a5ef45dffedff844f7f4c2bad52d9245e666b96500c4778982c8e218b8b6fd267dab638fb707"} 04:39:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:39:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:39:59 INFO - Contents: 04:39:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b318dee2595cd071128ca943e005e178fc4f4a8af4e364fd2eee0c4a7a1780680f7279cb06421f1650061c728ee40c79f6985701cf8b9cca53d5bfb4a4dd68d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/03e04cd8e3a6de54ca69c0332587bf5287deb05bc714161d18f1a5ef45dffedff844f7f4c2bad52d9245e666b96500c4778982c8e218b8b6fd267dab638fb707"} 04:39:59 INFO - Running post-run listener: copy_logs_to_upload_dir 04:39:59 INFO - Copying logs to upload dir... 04:39:59 INFO - mkdir: /builds/slave/test/build/upload/logs 04:39:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.858802 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-08 04:39:59.302165) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 04:39:59.306142) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708 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/b318dee2595cd071128ca943e005e178fc4f4a8af4e364fd2eee0c4a7a1780680f7279cb06421f1650061c728ee40c79f6985701cf8b9cca53d5bfb4a4dd68d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/03e04cd8e3a6de54ca69c0332587bf5287deb05bc714161d18f1a5ef45dffedff844f7f4c2bad52d9245e666b96500c4778982c8e218b8b6fd267dab638fb707"} build_url:https://queue.taskcluster.net/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/F5cGCmYRQuKgNGzoiGVzuQ/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/b318dee2595cd071128ca943e005e178fc4f4a8af4e364fd2eee0c4a7a1780680f7279cb06421f1650061c728ee40c79f6985701cf8b9cca53d5bfb4a4dd68d1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/03e04cd8e3a6de54ca69c0332587bf5287deb05bc714161d18f1a5ef45dffedff844f7f4c2bad52d9245e666b96500c4778982c8e218b8b6fd267dab638fb707"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 04:39:59.360249) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:39:59.360614) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1460114293.258052-1949338708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:39:59.474418) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 04:39:59.474750) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 04:39:59.475055) ========= ========= Total master_lag: 0.38 =========