builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1460114176.08 results: success (0) buildid: 20160408030000 builduid: 5d4b3832a52842e3a0a31d9ca975fdaa revision: e7466050cdd23e629ffbe97bfa9b8226d3cb7980 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.084587) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.085551) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.086304) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006365 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.119964) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.120259) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.151281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.151554) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.205158) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.205549) ========= 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:16:16.205920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.206205) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-08 04:16:16-- 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% 222M=0s 2016-04-08 04:16:16 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101564 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.326491) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.326772) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022898 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.385929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.386260) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e7466050cdd23e629ffbe97bfa9b8226d3cb7980 --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 e7466050cdd23e629ffbe97bfa9b8226d3cb7980 --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=2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-08 04:16:16,878 truncating revision to first 12 chars 2016-04-08 04:16:16,879 Setting DEBUG logging. 2016-04-08 04:16:16,879 attempt 1/10 2016-04-08 04:16:16,879 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e7466050cdd2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 04:16:17,144 unpacking tar archive at: mozilla-central-e7466050cdd2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531936 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.934079) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.934407) ========= echo e7466050cdd23e629ffbe97bfa9b8226d3cb7980 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e7466050cdd23e629ffbe97bfa9b8226d3cb7980'] 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=2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False e7466050cdd23e629ffbe97bfa9b8226d3cb7980 program finished with exit code 0 elapsedTime=0.004763 script_repo_revision: 'e7466050cdd23e629ffbe97bfa9b8226d3cb7980' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.991542) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:16.991819) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 04:16:17.003712) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-08 04:16:17.003986) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:16:17 INFO - MultiFileLogger online at 20160408 04:16:17 in /builds/slave/test 04:16:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:16:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:16:17 INFO - {'append_to_log': False, 04:16:17 INFO - 'base_work_dir': '/builds/slave/test', 04:16:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:16:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:16:17 INFO - 'branch': 'Firefox-Non-PGO', 04:16:17 INFO - 'buildbot_json_path': 'buildprops.json', 04:16:17 INFO - 'config_files': ('talos/linux_config.py',), 04:16:17 INFO - 'default_actions': ('clobber', 04:16:17 INFO - 'read-buildbot-config', 04:16:17 INFO - 'download-and-extract', 04:16:17 INFO - 'populate-webroot', 04:16:17 INFO - 'create-virtualenv', 04:16:17 INFO - 'install', 04:16:17 INFO - 'run-tests'), 04:16:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:16:17 INFO - 'download_minidump_stackwalk': True, 04:16:17 INFO - 'download_symbols': 'ondemand', 04:16:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:16:17 INFO - 'tooltool.py': '/tools/tooltool.py', 04:16:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:16:17 INFO - '/tools/misc-python/virtualenv.py')}, 04:16:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:16:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:16:17 INFO - 'installer_path': 'installer.exe', 04:16:17 INFO - 'log_level': 'info', 04:16:17 INFO - 'log_name': 'talos', 04:16:17 INFO - 'log_to_console': True, 04:16:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:16:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:16:17 INFO - 'opt_config_files': (), 04:16:17 INFO - 'pip_index': False, 04:16:17 INFO - 'sps_profile': False, 04:16:17 INFO - 'sps_profile_interval': 0, 04:16:17 INFO - 'suite': 'dromaeojs-e10s', 04:16:17 INFO - 'system_bits': '32', 04:16:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:16:17 INFO - 'title': 'talos-linux64-ix-012', 04:16:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:16:17 INFO - 'use_talos_json': True, 04:16:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:16:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:16:17 INFO - 'work_dir': 'build'} 04:16:17 INFO - ##### 04:16:17 INFO - ##### Running clobber step. 04:16:17 INFO - ##### 04:16:17 INFO - Running pre-action listener: _resource_record_pre_action 04:16:17 INFO - Running main action method: clobber 04:16:17 INFO - rmtree: /builds/slave/test/build 04:16:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:16:18 INFO - Running post-action listener: _resource_record_post_action 04:16:18 INFO - ##### 04:16:18 INFO - ##### Running read-buildbot-config step. 04:16:18 INFO - ##### 04:16:18 INFO - Running pre-action listener: _resource_record_pre_action 04:16:18 INFO - Running main action method: read_buildbot_config 04:16:18 INFO - Using buildbot properties: 04:16:18 INFO - { 04:16:18 INFO - "project": "", 04:16:18 INFO - "product": "firefox", 04:16:18 INFO - "script_repo_revision": "production", 04:16:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:16:18 INFO - "repository": "", 04:16:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:16:18 INFO - "buildid": "20160408030000", 04:16:18 INFO - "pgo_build": "False", 04:16:18 INFO - "basedir": "/builds/slave/test", 04:16:18 INFO - "buildnumber": 277, 04:16:18 INFO - "slavename": "talos-linux64-ix-012", 04:16:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:16:18 INFO - "platform": "ubuntu64_hw", 04:16:18 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:16:18 INFO - "branch": "mozilla-central", 04:16:18 INFO - "repo_path": "mozilla-central", 04:16:18 INFO - "revision": "e7466050cdd23e629ffbe97bfa9b8226d3cb7980", 04:16:18 INFO - "stage_platform": "linux64", 04:16:18 INFO - "builduid": "5d4b3832a52842e3a0a31d9ca975fdaa", 04:16:18 INFO - "slavebuilddir": "test" 04:16:18 INFO - } 04:16:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:16:18 INFO - Running post-action listener: _resource_record_post_action 04:16:18 INFO - ##### 04:16:18 INFO - ##### Running download-and-extract step. 04:16:18 INFO - ##### 04:16:18 INFO - Running pre-action listener: _resource_record_pre_action 04:16:18 INFO - Running main action method: download_and_extract 04:16:18 INFO - mkdir: /builds/slave/test/build/tests 04:16: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:16:18 INFO - https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:16:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:16:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:16:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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:16:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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:16:25 INFO - Downloaded 1361 bytes. 04:16:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:16:25 INFO - Using the following test package requirements: 04:16:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:16:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:16:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:25 INFO - u'jsshell-linux-x86_64.zip'], 04:16:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:16:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:16:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:16:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:16:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:16:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:16:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:16:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:16:25 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:16:25 INFO - https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:16:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:16:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:16:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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:16:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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:16:29 INFO - Downloaded 22186012 bytes. 04:16:29 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:16:29 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:16:31 INFO - Return code: 0 04:16:31 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:16: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:16:31 INFO - https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:16:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:16:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:16:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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:16:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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:16:39 INFO - Downloaded 22186012 bytes. 04:16:39 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:16:39 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:16:41 INFO - Return code: 0 04:16: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:16:41 INFO - https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:16:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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:16:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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:16:42 INFO - Downloaded 10847693 bytes. 04:16:42 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:16:42 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:16:42 INFO - Return code: 0 04:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:42 INFO - https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:16:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:16:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:16:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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:16:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/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:16:44 INFO - Downloaded 54053591 bytes. 04:16:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:16:44 INFO - mkdir: /builds/slave/test/properties 04:16:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:16:44 INFO - Writing to file /builds/slave/test/properties/build_url 04:16:44 INFO - Contents: 04:16:44 INFO - build_url:https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:16:45 INFO - Running post-action listener: _resource_record_post_action 04:16:45 INFO - Running post-action listener: set_extra_try_arguments 04:16:45 INFO - ##### 04:16:45 INFO - ##### Running populate-webroot step. 04:16:45 INFO - ##### 04:16:45 INFO - Running pre-action listener: _resource_record_pre_action 04:16:45 INFO - Running main action method: populate_webroot 04:16:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:16:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:16:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:16:45 INFO - '--tppagecycles', 04:16:45 INFO - '7'], 04:16:45 INFO - 'tests': ['tsvgm']}}, 04:16:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:16:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:16:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:16:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:16:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:16:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:16:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:45 INFO - 'talos_options': ['--disable-e10s'], 04:16:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:45 INFO - 'talos_options': ['--disable-e10s'], 04:16:45 INFO - 'tests': ['damp', 'tps']}, 04:16:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:45 INFO - 'tests': ['damp', 'tps']}, 04:16:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:16:45 INFO - 'tests': ['dromaeo_dom']}, 04:16:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:16:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:16:45 INFO - 'tests': ['a11yr', 04:16:45 INFO - 'ts_paint', 04:16:45 INFO - 'tpaint', 04:16:45 INFO - 'sessionrestore', 04:16:45 INFO - 'sessionrestore_no_auto_restore', 04:16:45 INFO - 'tabpaint']}, 04:16:45 INFO - 'other-e10s': {'tests': ['a11yr', 04:16:45 INFO - 'ts_paint', 04:16:45 INFO - 'tpaint', 04:16:45 INFO - 'sessionrestore', 04:16:45 INFO - 'sessionrestore_no_auto_restore', 04:16:45 INFO - 'tabpaint']}, 04:16:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:16:45 INFO - 'ts_paint', 04:16:45 INFO - 'tpaint', 04:16:45 INFO - 'sessionrestore', 04:16:45 INFO - 'sessionrestore_no_auto_restore', 04:16:45 INFO - 'tabpaint']}, 04:16:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:16:45 INFO - 'ts_paint', 04:16:45 INFO - 'tpaint', 04:16:45 INFO - 'sessionrestore', 04:16:45 INFO - 'sessionrestore_no_auto_restore', 04:16:45 INFO - 'tabpaint']}, 04:16:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:16:45 INFO - 'tests': ['a11yr', 04:16:45 INFO - 'ts_paint', 04:16:45 INFO - 'tpaint', 04:16:45 INFO - 'sessionrestore', 04:16:45 INFO - 'sessionrestore_no_auto_restore', 04:16:45 INFO - 'tabpaint']}, 04:16:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:16:45 INFO - 'tests': ['a11yr', 04:16:45 INFO - 'ts_paint', 04:16:45 INFO - 'tpaint', 04:16:45 INFO - 'sessionrestore', 04:16:45 INFO - 'sessionrestore_no_auto_restore', 04:16:45 INFO - 'tabpaint']}, 04:16:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:16:45 INFO - 'tests': ['tsvgx', 04:16:45 INFO - 'tsvgr_opacity', 04:16:45 INFO - 'tart', 04:16:45 INFO - 'tscrollx', 04:16:45 INFO - 'cart']}, 04:16:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:16:45 INFO - 'tsvgr_opacity', 04:16:45 INFO - 'tart', 04:16:45 INFO - 'tscrollx', 04:16:45 INFO - 'cart']}, 04:16:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:45 INFO - 'talos_options': ['--disable-e10s'], 04:16:45 INFO - 'tests': ['tp5o']}, 04:16:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:45 INFO - 'tests': ['tp5o']}, 04:16:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:45 INFO - 'talos_options': ['--disable-e10s', 04:16:45 INFO - '--xperf_path', 04:16:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:45 INFO - 'tests': ['tp5n']}, 04:16:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:45 INFO - 'talos_options': ['--xperf_path', 04:16:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:45 INFO - 'tests': ['tp5n']}}, 04:16:45 INFO - 'talos.zip': {'path': '', 04:16:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:16:45 INFO - Running post-action listener: _resource_record_post_action 04:16:45 INFO - ##### 04:16:45 INFO - ##### Running create-virtualenv step. 04:16:45 INFO - ##### 04:16:45 INFO - Running pre-action listener: _resource_record_pre_action 04:16:45 INFO - Running main action method: create_virtualenv 04:16:45 INFO - Creating virtualenv /builds/slave/test/build/venv 04:16:45 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:16:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:16:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:16:45 INFO - Using real prefix '/usr' 04:16:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:16:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:16:47 INFO - Installing pip.................done. 04:16:47 INFO - Return code: 0 04:16:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:47 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 0x7f0e13681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21205a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af410>, '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 0x21b0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b07a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', '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:16:47 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:16:47 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:16:47 INFO - Using env: {'DISPLAY': ':0', 04:16:47 INFO - 'HOME': '/home/cltbld', 04:16:47 INFO - 'LANG': 'en_US.UTF-8', 04:16:47 INFO - 'LANGUAGE': 'en_US:en', 04:16:47 INFO - 'LOGNAME': 'cltbld', 04:16:47 INFO - 'MAIL': '/var/mail/cltbld', 04:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:47 INFO - 'MOZ_NO_REMOTE': '1', 04:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:47 INFO - 'NO_EM_RESTART': '1', 04:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:47 INFO - 'PWD': '/builds/slave/test', 04:16:47 INFO - 'SHELL': '/bin/bash', 04:16:47 INFO - 'SHLVL': '1', 04:16:47 INFO - 'TERM': 'linux', 04:16:47 INFO - 'TMOUT': '86400', 04:16:47 INFO - 'USER': 'cltbld', 04:16:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', 04:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:47 INFO - '_': '/tools/buildbot/bin/python'} 04:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:48 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:16:48 INFO - Cleaning up... 04:16:48 INFO - Return code: 0 04:16:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:16: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:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16: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:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0e13681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21205a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af410>, '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 0x21b0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b07a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', '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:16:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:16:48 INFO - Using env: {'DISPLAY': ':0', 04:16:48 INFO - 'HOME': '/home/cltbld', 04:16:48 INFO - 'LANG': 'en_US.UTF-8', 04:16:48 INFO - 'LANGUAGE': 'en_US:en', 04:16:48 INFO - 'LOGNAME': 'cltbld', 04:16:48 INFO - 'MAIL': '/var/mail/cltbld', 04:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:48 INFO - 'MOZ_NO_REMOTE': '1', 04:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:48 INFO - 'NO_EM_RESTART': '1', 04:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:48 INFO - 'PWD': '/builds/slave/test', 04:16:48 INFO - 'SHELL': '/bin/bash', 04:16:48 INFO - 'SHLVL': '1', 04:16:48 INFO - 'TERM': 'linux', 04:16:48 INFO - 'TMOUT': '86400', 04:16:48 INFO - 'USER': 'cltbld', 04:16:48 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', 04:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:48 INFO - '_': '/tools/buildbot/bin/python'} 04:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:48 INFO - Downloading/unpacking psutil>=0.7.1 04:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:16:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:50 INFO - Installing collected packages: psutil 04:16:50 INFO - Running setup.py install for psutil 04:16:50 INFO - building 'psutil._psutil_linux' extension 04:16:50 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:16:50 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:16:50 INFO - building 'psutil._psutil_posix' extension 04:16:50 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:16:50 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:16:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:50 INFO - Successfully installed psutil 04:16:50 INFO - Cleaning up... 04:16:51 INFO - Return code: 0 04:16:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:16: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:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16: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:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0e13681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21205a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af410>, '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 0x21b0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b07a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', '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:16:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:16:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:16:51 INFO - Using env: {'DISPLAY': ':0', 04:16:51 INFO - 'HOME': '/home/cltbld', 04:16:51 INFO - 'LANG': 'en_US.UTF-8', 04:16:51 INFO - 'LANGUAGE': 'en_US:en', 04:16:51 INFO - 'LOGNAME': 'cltbld', 04:16:51 INFO - 'MAIL': '/var/mail/cltbld', 04:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:51 INFO - 'MOZ_NO_REMOTE': '1', 04:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:51 INFO - 'NO_EM_RESTART': '1', 04:16:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:51 INFO - 'PWD': '/builds/slave/test', 04:16:51 INFO - 'SHELL': '/bin/bash', 04:16:51 INFO - 'SHLVL': '1', 04:16:51 INFO - 'TERM': 'linux', 04:16:51 INFO - 'TMOUT': '86400', 04:16:51 INFO - 'USER': 'cltbld', 04:16:51 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', 04:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:51 INFO - '_': '/tools/buildbot/bin/python'} 04:16:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:16:51 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:16:51 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:16:51 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:16:51 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:16:51 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:16:51 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:16:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:16:53 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:16:53 INFO - Installing collected packages: mozsystemmonitor 04:16:53 INFO - Running setup.py install for mozsystemmonitor 04:16:53 INFO - Successfully installed mozsystemmonitor 04:16:53 INFO - Cleaning up... 04:16:53 INFO - Return code: 0 04:16:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:16:53 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:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:53 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:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:53 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 0x7f0e13681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21205a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af410>, '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 0x21b0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b07a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', '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:16:53 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:16:53 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:16:53 INFO - Using env: {'DISPLAY': ':0', 04:16:53 INFO - 'HOME': '/home/cltbld', 04:16:53 INFO - 'LANG': 'en_US.UTF-8', 04:16:53 INFO - 'LANGUAGE': 'en_US:en', 04:16:53 INFO - 'LOGNAME': 'cltbld', 04:16:53 INFO - 'MAIL': '/var/mail/cltbld', 04:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:53 INFO - 'MOZ_NO_REMOTE': '1', 04:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:53 INFO - 'NO_EM_RESTART': '1', 04:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:53 INFO - 'PWD': '/builds/slave/test', 04:16:53 INFO - 'SHELL': '/bin/bash', 04:16:53 INFO - 'SHLVL': '1', 04:16:53 INFO - 'TERM': 'linux', 04:16:53 INFO - 'TMOUT': '86400', 04:16:53 INFO - 'USER': 'cltbld', 04:16:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', 04:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:53 INFO - '_': '/tools/buildbot/bin/python'} 04:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:53 INFO - Downloading/unpacking blobuploader==1.2.4 04:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:56 INFO - Downloading blobuploader-1.2.4.tar.gz 04:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:16:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:16: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:16: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:16: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:16: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:16: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:16: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:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:16:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:16: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:16: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:16: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:16: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:16: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:16: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:16:57 INFO - Downloading docopt-0.6.1.tar.gz 04:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:16:57 INFO - Installing collected packages: blobuploader, requests, docopt 04:16:57 INFO - Running setup.py install for blobuploader 04:16:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:16:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:16:57 INFO - Running setup.py install for requests 04:16:57 INFO - Running setup.py install for docopt 04:16:57 INFO - Successfully installed blobuploader requests docopt 04:16:57 INFO - Cleaning up... 04:16:57 INFO - Return code: 0 04:16:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:57 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 0x7f0e13681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21205a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af410>, '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 0x21b0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b07a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', '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:16:57 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:16:57 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:16:57 INFO - Using env: {'DISPLAY': ':0', 04:16:57 INFO - 'HOME': '/home/cltbld', 04:16:57 INFO - 'LANG': 'en_US.UTF-8', 04:16:57 INFO - 'LANGUAGE': 'en_US:en', 04:16:57 INFO - 'LOGNAME': 'cltbld', 04:16:57 INFO - 'MAIL': '/var/mail/cltbld', 04:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:57 INFO - 'MOZ_NO_REMOTE': '1', 04:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:57 INFO - 'NO_EM_RESTART': '1', 04:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:57 INFO - 'PWD': '/builds/slave/test', 04:16:57 INFO - 'SHELL': '/bin/bash', 04:16:57 INFO - 'SHLVL': '1', 04:16:57 INFO - 'TERM': 'linux', 04:16:57 INFO - 'TMOUT': '86400', 04:16:57 INFO - 'USER': 'cltbld', 04:16:57 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', 04:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:57 INFO - '_': '/tools/buildbot/bin/python'} 04:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:57 INFO - Running setup.py (path:/tmp/pip-txOHBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:58 INFO - Running setup.py (path:/tmp/pip-npzypz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:58 INFO - Running setup.py (path:/tmp/pip-lOhBpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:58 INFO - Running setup.py (path:/tmp/pip-oANgVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:58 INFO - Running setup.py (path:/tmp/pip-QEKOTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:58 INFO - Running setup.py (path:/tmp/pip-tbGolI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:58 INFO - Running setup.py (path:/tmp/pip-EeXwHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:58 INFO - Running setup.py (path:/tmp/pip-6Y3sLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:58 INFO - Running setup.py (path:/tmp/pip-7yKHht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:58 INFO - Running setup.py (path:/tmp/pip-3aBALb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:58 INFO - Running setup.py (path:/tmp/pip-_3QYKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:58 INFO - Running setup.py (path:/tmp/pip-XfWiyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:58 INFO - Running setup.py (path:/tmp/pip-twTM6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:58 INFO - Running setup.py (path:/tmp/pip-3cqDgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:58 INFO - Running setup.py (path:/tmp/pip-Y5fbug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:59 INFO - Running setup.py (path:/tmp/pip-d6eCte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:59 INFO - Running setup.py (path:/tmp/pip-3sbh_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:16:59 INFO - Running setup.py install for manifestparser 04:16:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:16:59 INFO - Running setup.py install for mozcrash 04:16:59 INFO - Running setup.py install for mozdebug 04:16:59 INFO - Running setup.py install for mozdevice 04:16:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:16:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:16:59 INFO - Running setup.py install for mozfile 04:16:59 INFO - Running setup.py install for mozhttpd 04:16:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:16:59 INFO - Running setup.py install for mozinfo 04:16:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:16:59 INFO - Running setup.py install for mozInstall 04:16:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:16:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:16:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:16:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:16:59 INFO - Running setup.py install for mozleak 04:17:00 INFO - Running setup.py install for mozlog 04:17:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:17:00 INFO - Running setup.py install for moznetwork 04:17:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:17:00 INFO - Running setup.py install for mozprocess 04:17:00 INFO - Running setup.py install for mozprofile 04:17:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:17:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:17:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:17:00 INFO - Running setup.py install for mozrunner 04:17:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:17:00 INFO - Running setup.py install for mozscreenshot 04:17:00 INFO - Running setup.py install for moztest 04:17:00 INFO - Running setup.py install for mozversion 04:17:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:17:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:17:00 INFO - Cleaning up... 04:17:00 INFO - Return code: 0 04:17:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:00 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 0x7f0e13681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21205a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af410>, '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 0x21b0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b07a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', '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:17:00 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:17:00 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:17:00 INFO - Using env: {'DISPLAY': ':0', 04:17:00 INFO - 'HOME': '/home/cltbld', 04:17:00 INFO - 'LANG': 'en_US.UTF-8', 04:17:00 INFO - 'LANGUAGE': 'en_US:en', 04:17:00 INFO - 'LOGNAME': 'cltbld', 04:17:00 INFO - 'MAIL': '/var/mail/cltbld', 04:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:00 INFO - 'MOZ_NO_REMOTE': '1', 04:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:00 INFO - 'NO_EM_RESTART': '1', 04:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:00 INFO - 'PWD': '/builds/slave/test', 04:17:00 INFO - 'SHELL': '/bin/bash', 04:17:00 INFO - 'SHLVL': '1', 04:17:00 INFO - 'TERM': 'linux', 04:17:00 INFO - 'TMOUT': '86400', 04:17:00 INFO - 'USER': 'cltbld', 04:17:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', 04:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:00 INFO - '_': '/tools/buildbot/bin/python'} 04:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:01 INFO - Running setup.py (path:/tmp/pip-TD52Ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:01 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:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:01 INFO - Running setup.py (path:/tmp/pip-U6O1Qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:01 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:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:01 INFO - Running setup.py (path:/tmp/pip-H73W2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:01 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:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:01 INFO - Running setup.py (path:/tmp/pip-ADkmwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:01 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:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:01 INFO - Running setup.py (path:/tmp/pip-ZDoIop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:01 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:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:01 INFO - Running setup.py (path:/tmp/pip-phNwNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:01 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:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:01 INFO - Running setup.py (path:/tmp/pip-xNBu9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:01 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:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:01 INFO - Running setup.py (path:/tmp/pip-QWtNiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:01 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:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:01 INFO - Running setup.py (path:/tmp/pip-qQXP1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:01 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:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:01 INFO - Running setup.py (path:/tmp/pip-Cjl6kW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:01 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:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:01 INFO - Running setup.py (path:/tmp/pip-fpeBNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:01 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:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:01 INFO - Running setup.py (path:/tmp/pip-ZI8dQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:02 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:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:02 INFO - Running setup.py (path:/tmp/pip-p14_Eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:02 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:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:02 INFO - Running setup.py (path:/tmp/pip-Cyy4ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:02 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:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:02 INFO - Running setup.py (path:/tmp/pip-a7RRKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:02 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:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:02 INFO - Running setup.py (path:/tmp/pip-cDugIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:02 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:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:02 INFO - Running setup.py (path:/tmp/pip-Bqecmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:02 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:17:02 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:17:02 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:17:02 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:17:02 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:17:02 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:17:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:04 INFO - Downloading blessings-1.6.tar.gz 04:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:17:04 INFO - Installing collected packages: blessings 04:17:04 INFO - Running setup.py install for blessings 04:17:04 INFO - Successfully installed blessings 04:17:04 INFO - Cleaning up... 04:17:04 INFO - Return code: 0 04:17:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:17:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:04 INFO - Reading from file tmpfile_stdout 04:17:04 INFO - Current package versions: 04:17:04 INFO - argparse == 1.2.1 04:17:04 INFO - blessings == 1.6 04:17:04 INFO - blobuploader == 1.2.4 04:17:04 INFO - docopt == 0.6.1 04:17:04 INFO - manifestparser == 1.1 04:17:04 INFO - mozInstall == 1.12 04:17:04 INFO - mozcrash == 0.17 04:17:04 INFO - mozdebug == 0.1 04:17:04 INFO - mozdevice == 0.48 04:17:04 INFO - mozfile == 1.2 04:17:04 INFO - mozhttpd == 0.7 04:17:04 INFO - mozinfo == 0.9 04:17:04 INFO - mozleak == 0.1 04:17:04 INFO - mozlog == 3.1 04:17:04 INFO - moznetwork == 0.27 04:17:04 INFO - mozprocess == 0.22 04:17:04 INFO - mozprofile == 0.28 04:17:04 INFO - mozrunner == 6.11 04:17:04 INFO - mozscreenshot == 0.1 04:17:04 INFO - mozsystemmonitor == 0.0 04:17:04 INFO - moztest == 0.7 04:17:04 INFO - mozversion == 1.4 04:17:04 INFO - psutil == 3.1.1 04:17:04 INFO - requests == 1.2.3 04:17:04 INFO - wsgiref == 0.1.2 04:17:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:04 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 0x7f0e13681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21205a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af410>, '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 0x21b0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b07a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', '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:17:04 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:17:04 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:17:04 INFO - Using env: {'DISPLAY': ':0', 04:17:04 INFO - 'HOME': '/home/cltbld', 04:17:04 INFO - 'LANG': 'en_US.UTF-8', 04:17:04 INFO - 'LANGUAGE': 'en_US:en', 04:17:04 INFO - 'LOGNAME': 'cltbld', 04:17:04 INFO - 'MAIL': '/var/mail/cltbld', 04:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:04 INFO - 'MOZ_NO_REMOTE': '1', 04:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:04 INFO - 'NO_EM_RESTART': '1', 04:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:04 INFO - 'PWD': '/builds/slave/test', 04:17:04 INFO - 'SHELL': '/bin/bash', 04:17:04 INFO - 'SHLVL': '1', 04:17:04 INFO - 'TERM': 'linux', 04:17:04 INFO - 'TMOUT': '86400', 04:17:04 INFO - 'USER': 'cltbld', 04:17:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', 04:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:04 INFO - '_': '/tools/buildbot/bin/python'} 04:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:05 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:17:05 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:17:05 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:17:05 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:17:05 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:17:05 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:17:05 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:17:05 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:17:05 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:17:05 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:17:05 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:17:05 INFO - Cleaning up... 04:17:05 INFO - Return code: 0 04:17:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:17:05 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:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:05 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:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:05 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 0x7f0e13681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21205a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af410>, '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 0x21b0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b07a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', '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:17:05 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:17:05 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:17:05 INFO - Using env: {'DISPLAY': ':0', 04:17:05 INFO - 'HOME': '/home/cltbld', 04:17:05 INFO - 'LANG': 'en_US.UTF-8', 04:17:05 INFO - 'LANGUAGE': 'en_US:en', 04:17:05 INFO - 'LOGNAME': 'cltbld', 04:17:05 INFO - 'MAIL': '/var/mail/cltbld', 04:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:05 INFO - 'MOZ_NO_REMOTE': '1', 04:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:05 INFO - 'NO_EM_RESTART': '1', 04:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:05 INFO - 'PWD': '/builds/slave/test', 04:17:05 INFO - 'SHELL': '/bin/bash', 04:17:05 INFO - 'SHLVL': '1', 04:17:05 INFO - 'TERM': 'linux', 04:17:05 INFO - 'TMOUT': '86400', 04:17:05 INFO - 'USER': 'cltbld', 04:17:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', 04:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:05 INFO - '_': '/tools/buildbot/bin/python'} 04:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:05 INFO - Downloading/unpacking jsonschema 04:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:17:07 INFO - Downloading/unpacking functools32 (from jsonschema) 04:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:07 INFO - Downloading functools32-3.2.3-2.tar.gz 04:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:17:07 INFO - warning: no files found matching '*.txt' 04:17:07 INFO - no previously-included directories found matching 'build' 04:17:07 INFO - no previously-included directories found matching 'dist' 04:17:07 INFO - no previously-included directories found matching '.git*' 04:17:07 INFO - Installing collected packages: jsonschema, functools32 04:17:07 INFO - Running setup.py install for functools32 04:17:07 INFO - warning: no files found matching '*.txt' 04:17:07 INFO - no previously-included directories found matching 'build' 04:17:07 INFO - no previously-included directories found matching 'dist' 04:17:07 INFO - no previously-included directories found matching '.git*' 04:17:07 INFO - Successfully installed jsonschema functools32 04:17:07 INFO - Cleaning up... 04:17:07 INFO - Return code: 0 04:17:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e13681f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21205a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af410>, '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 0x21b0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b07a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', '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:17:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:17:07 INFO - Using env: {'DISPLAY': ':0', 04:17:07 INFO - 'HOME': '/home/cltbld', 04:17:07 INFO - 'LANG': 'en_US.UTF-8', 04:17:07 INFO - 'LANGUAGE': 'en_US:en', 04:17:07 INFO - 'LOGNAME': 'cltbld', 04:17:07 INFO - 'MAIL': '/var/mail/cltbld', 04:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:07 INFO - 'MOZ_NO_REMOTE': '1', 04:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:07 INFO - 'NO_EM_RESTART': '1', 04:17:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:07 INFO - 'PWD': '/builds/slave/test', 04:17:07 INFO - 'SHELL': '/bin/bash', 04:17:07 INFO - 'SHLVL': '1', 04:17:07 INFO - 'TERM': 'linux', 04:17:07 INFO - 'TMOUT': '86400', 04:17:07 INFO - 'USER': 'cltbld', 04:17:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', 04:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:07 INFO - '_': '/tools/buildbot/bin/python'} 04:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:08 INFO - Downloading/unpacking flake8 04:17:08 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:17:08 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:17:08 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:17:08 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:17:08 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:17:08 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:17:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:17:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:17:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:17:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:17:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:17:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:17:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:17:10 INFO - no previously-included directories found matching 'docs/_build' 04:17:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:17:10 INFO - Running setup.py install for pep8 04:17:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:17:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:17:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:17:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:17:11 INFO - no previously-included directories found matching 'docs/_build' 04:17:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:17:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:17:11 INFO - Cleaning up... 04:17:11 INFO - Return code: 0 04:17:11 INFO - Running post-action listener: _resource_record_post_action 04:17:11 INFO - Running post-action listener: _start_resource_monitoring 04:17:11 INFO - Starting resource monitoring. 04:17:11 INFO - ##### 04:17:11 INFO - ##### Running install step. 04:17:11 INFO - ##### 04:17:11 INFO - Running pre-action listener: _resource_record_pre_action 04:17:11 INFO - Running main action method: install 04:17:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:11 INFO - Reading from file tmpfile_stdout 04:17:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:17:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:17:11 INFO - Reading from file tmpfile_stdout 04:17:11 INFO - Output received: 04:17:11 INFO - Usage: mozinstall [options] installer 04:17:11 INFO - Options: 04:17:11 INFO - -h, --help show this help message and exit 04:17:11 INFO - -d DEST, --destination=DEST 04:17:11 INFO - Directory to install application into. [default: 04:17:11 INFO - "/builds/slave/test"] 04:17:11 INFO - --app=APP Application being installed. [default: firefox] 04:17:11 INFO - mkdir: /builds/slave/test/build/application 04:17:11 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:17:11 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:17:27 INFO - Reading from file tmpfile_stdout 04:17:27 INFO - Output received: 04:17:27 INFO - /builds/slave/test/build/application/firefox/firefox 04:17:27 INFO - Running post-action listener: _resource_record_post_action 04:17:27 INFO - ##### 04:17:27 INFO - ##### Running run-tests step. 04:17:27 INFO - ##### 04:17:27 INFO - Running pre-action listener: _resource_record_pre_action 04:17:27 INFO - Running main action method: run_tests 04:17:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:17:27 INFO - Python 2.7.3 04:17:27 INFO - Return code: 0 04:17:27 INFO - grabbing minidump binary from tooltool 04:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:27 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 0x21af410>, '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 0x21b0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b07a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:17:27 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:17:27 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:17:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:17:27 INFO - Return code: 0 04:17:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:17:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:17:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:17:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:17:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:17:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:17:28 INFO - Return code: 0 04:17:28 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:17:28 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:17:28 INFO - Using env: {'DISPLAY': ':0', 04:17:28 INFO - 'HOME': '/home/cltbld', 04:17:28 INFO - 'LANG': 'en_US.UTF-8', 04:17:28 INFO - 'LANGUAGE': 'en_US:en', 04:17:28 INFO - 'LOGNAME': 'cltbld', 04:17:28 INFO - 'MAIL': '/var/mail/cltbld', 04:17:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:17:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:28 INFO - 'MOZ_NO_REMOTE': '1', 04:17:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:17:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:28 INFO - 'NO_EM_RESTART': '1', 04:17:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:28 INFO - 'PWD': '/builds/slave/test', 04:17:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:17:28 INFO - 'SHELL': '/bin/bash', 04:17:28 INFO - 'SHLVL': '1', 04:17:28 INFO - 'TERM': 'linux', 04:17:28 INFO - 'TMOUT': '86400', 04:17:28 INFO - 'USER': 'cltbld', 04:17:28 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879', 04:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:28 INFO - '_': '/tools/buildbot/bin/python'} 04:17:28 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:17:28 INFO - mozversion application_buildid: 20160408030000 04:17:28 INFO - mozversion application_changeset: e7466050cdd23e629ffbe97bfa9b8226d3cb7980 04:17:28 INFO - mozversion application_display_name: Nightly 04:17:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:17:28 INFO - mozversion application_name: Firefox 04:17:28 INFO - mozversion application_remotingname: firefox 04:17:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:17:28 INFO - mozversion application_vendor: Mozilla 04:17:28 INFO - mozversion application_version: 48.0a1 04:17:28 INFO - mozversion platform_buildid: 20160408030000 04:17:28 INFO - mozversion platform_changeset: e7466050cdd23e629ffbe97bfa9b8226d3cb7980 04:17:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:17:28 INFO - mozversion platform_version: 48.0a1 04:17:28 INFO - using testdate: 1460114248 04:17:28 INFO - actual date: 1460114248 04:17:28 INFO - starting webserver on 'localhost:60551' 04:17:28 INFO - SUITE-START | Running 2 tests 04:17:28 INFO - TEST-START | dromaeo_css 04:17:28 INFO - operating with platform_type : linux_ 04:17:28 INFO - Initialising browser for dromaeo_css test... 04:17:28 INFO - TEST-INFO | started process 28487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2F5w8R/profile http://localhost:60551/getInfo.html) 04:17:31 INFO - PROCESS | 28487 | 04:17:31 INFO - PROCESS | 28487 | (process:28553): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:17:32 INFO - PROCESS | 28487 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 04:17:32 INFO - PROCESS | 28487 | __metrics Screen width/height:1600/1200 04:17:32 INFO - PROCESS | 28487 | colorDepth:24 04:17:32 INFO - PROCESS | 28487 | Browser inner width/height: 1024/697 04:17:32 INFO - PROCESS | 28487 | __metrics 04:17:33 ERROR - PROCESS | 28487 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 04:17:34 INFO - TEST-INFO | 28487: exit 0 04:17:34 INFO - Browser initialized. 04:17:34 INFO - Running cycle 1/1 for dromaeo_css test... 04:17:34 INFO - TEST-INFO | started process 28604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2F5w8R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:17:36 INFO - PROCESS | 28604 | 04:17:36 INFO - PROCESS | 28604 | (process:28667): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:17:46 INFO - PROCESS | 28604 | RSS: Main: 163635200 04:17:46 INFO - PROCESS | 28604 | 04:18:35 INFO - PROCESS | 28604 | 1460114315880 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:20:47 INFO - PROCESS | 28604 | Cycle 1(1): loaded http://localhost:60551/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60551/tests/dromaeo/cssquery-ext.html) 04:20:48 INFO - PROCESS | 28604 | RSS: Main: 168214528 04:20:48 INFO - PROCESS | 28604 | 04:23:50 INFO - PROCESS | 28604 | Cycle 1(1): loaded http://localhost:60551/tests/dromaeo/cssquery-ext.html (next: http://localhost:60551/tests/dromaeo/cssquery-jquery.html) 04:23:51 INFO - PROCESS | 28604 | RSS: Main: 165957632 04:23:51 INFO - PROCESS | 28604 | 04:26:53 INFO - PROCESS | 28604 | Cycle 1(1): loaded http://localhost:60551/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60551/tests/dromaeo/cssquery-mootools.html) 04:26:53 INFO - PROCESS | 28604 | RSS: Main: 166346752 04:26:53 INFO - PROCESS | 28604 | 04:29:55 INFO - PROCESS | 28604 | Cycle 1(1): loaded http://localhost:60551/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60551/tests/dromaeo/cssquery-prototype.html) 04:29:56 INFO - PROCESS | 28604 | RSS: Main: 164339712 04:29:56 INFO - PROCESS | 28604 | 04:32:58 INFO - PROCESS | 28604 | Cycle 1(1): loaded http://localhost:60551/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60551/tests/dromaeo/cssquery-yui.html) 04:32:59 INFO - PROCESS | 28604 | RSS: Main: 165048320 04:32:59 INFO - PROCESS | 28604 | 04:36:01 INFO - PROCESS | 28604 | Cycle 1(1): loaded http://localhost:60551/tests/dromaeo/cssquery-yui.html (next: http://localhost:60551/tests/dromaeo/cssquery-dojo.html) 04:36:02 INFO - PROCESS | 28604 | RSS: Main: 167157760 04:36:02 INFO - PROCESS | 28604 | 04:36:02 INFO - PROCESS | 28604 | __start_tp_report 04:36:02 INFO - PROCESS | 28604 | _x_x_mozilla_page_load 04:36:02 INFO - PROCESS | 28604 | _x_x_mozilla_page_load_details 04:36:02 INFO - PROCESS | 28604 | |i|pagename|runs| 04:36:02 INFO - PROCESS | 28604 | |0;dojo.html;2621.7378262173784;2706.404590989983;2731;2744.08073295446;2753.4630747004344;4612.953870461294;4616.33063205835;4617.868622187564;4652.232381657031;4660.7902644381;4574.451065872092;4652.8138874444985;4656.348111264426;4702.553257440538;4703.129920964615;4218.430511880895;4327.502337231212;4389.363542286366;4425.424694789689;4448.95449569351;4414.8300700314285;4426.867193984185;4459.152760975404;4470.865874023784;4499.055198408339;4193.287141186006;4298.441202643637;4439.045605194882;4466.821327146927;4485.327200919855;4267.997020700133;4271.572842715735;4273;4311.504177019651;4314.503832059322;4225.985763416788;4244.702870799046;4273.50854651716;4284.971606814373;4290.978545107255;4481.865544033684;4522.751248681321;4642.489326174118;4720.268358404453;4735.763211839429;5007.399112106534;5007.949920500785;5028.421731500851;5033.496650334974;5081.898362032739;5039.596832253411;5071.340725705634;5092.668976516515;5094.6433749637545;5094.77725345918;4579.152856721484;4680.789364478606;4753.762311884392;4759.714417134983;4810.206315957827;5165.690058596496;5188.636795424284;5195.064888320138;5195.19474481456;5218.165093585008;4814.037192561502;4936.975315123474;4967.925481117786;4980.377452818398;4981.975090124526;5033.446320904697;5066.594672426197;5096.235564665256;5119.769610367543;5138.87152821175;5008.699478031257;5035.144025515671;5044.419891712427;5047.066292735855;5078.13671675816;4871.244957031595;5005.5745261653165;5008.273800298936;5013.172826483589;5031.471695471922;4194.769287689145;4302.827886884552;4308.310670292738;4358.912821743547;4371.825126994948;3731.402975523903;3773.339665558571;3787.4697542344093;3806.390977443651;3855.5951625078965;4327.156204540084;4378.671599630041;4403.339499075164;4423.071155057474;4469.7988590513505;5099.490050994871;5111.105556527667;5111.718855462911;5114.795408183631;5155.510226528474;4408.911821763547;4424.823007079745;4427.5351088135285;4447.510773814878;4484.080763443486;4509.954900450954;4598.632109431237;4623.029163875556;4627.3521706961055;4686.906261874811;4800.4479484859685;4803.975980120077;4807.278908163804;4841.515848415131;4862.100511405401;5072.9746351268;5082.2122571001555;5091.0836049511445;5092.592592592509;5093.745312734422;4673.369095172108;4810.470848206624;4849.927251091166;4870.561649451566;4897.608191344755;5016.197408414636;5017.949820501748;5026.070177017264;5031.0441016206805;5088.59291256706;5108.59131269505;5111.46329635383;5114.616403769806;5119.641625086358;5127.077126117335;4771.403574553181;4881.658283920092;4927.827526036572;4939.950600494093;4962.925556116589;4902.754862256944;4931.72875491837;4940.530649588283;4944.777485013111;4998.900021999612;4720.173969555245;4867.80528778859;4868.780904859219;4878.0975519529;4888.437829649636;4827.589654879374;4922.630802689741;4936.136176169228;5020.598352131894;5029.874253143701;4777.3072904429355;4799.640026998059;4805.207140821725;4826.758662066953;4833.05755377698 04:36:02 INFO - PROCESS | 28604 | |1;ext.html;584.8099367705494;592.7984485275006;601.6540489218701;613.0711971363384;631.8483563944654;31820.36359272816;32741.50887736683;32759;32803.179920502;32808;32400.18999525013;32995.83502082486;33150.66849331506;33276.833615831885;33501.83249083757;7385.150707668619;7610.124835643916;7656.425768067417;7665.1951545087795;7673.117591476968;7624.771256862303;7658.2724641159;7700.4609677322605;7717.382609391263;7741.845163096735;7672.46292759507;7675.385969122484;7676.46264761467;7722.652480638357;7735.845283094335;7574.886376704354;7615.7334493292465;7664.348530374925;7687.231276872296;7690.730824421146;7598.962005189994;7663.6168191590195;7713.267239612228;7725.4205934554575;7729.149793522708;29361;34508.65491345105;34725.47911781325;34815.129621759406;34845.47731784;2928.502154633696;2990.2374894402005;3019.758419326449;3398.507216453625;3556.0754203906913;23868.88065559661;24065.278041658778;24306.27081187567;24866.627000595006;24921.376965575826;3300.96699033009;3344.899653010389;3370.3427831572853;3388.40702876998;3473.166440054394;184060;186170;186319;186571;186824;31516.527252091237;31781.84109079486;31852;33056.83471582627;33919.49120763191;31621.525677114863;31623.36753264922;31665;31683.20791980219;31751.84124079411;13285.535006274735;13401.53094641683;13478.797818032737;13493.460261589427;13506.122102063531;10895.727606809734;11007.834882476769;11063.225574209728;11075.667729968114;11093.389863557582;8052.677892884219;8056.879146812803;8062;8142.267195952392;8143.837123257502;3211.6627754085484;3215.3730022645827;3233.224026233687;3257.299680568689;3303.405387030358;911.5168960450972;936.2743873498093;949.5537097564134;972.027972027972;996.6960077176531;27269.590956135675;28358.85820570884;28422;28508.287292817844;28597.14208573746;1006.6074231049896;1008.4503945349802;1042.5152304178441;1058.687687132298;1063.3460421840666;14945.70108597822;15427.922860385626;15524.913256072192;15575.766363504557;15625.218739063;333818;340345;340842;341607;342022;48467;49462;49632.75183624059;49645.75177124091;49679;1203.6810245285008;1221.859486159103;1258.08160043169;1270.4600544768437;1278.7889998150388;26100.477990440464;27490.725092749617;27744.722552774212;27765.72234277712;27786.44427111487;41613.37579936364;41816.79091604644;42066;42090.7895460533;42160.789196053825;251377;251806;251991;253122;253132;25209.495810084063;25357.61963570511;25414.618780718672;25689.229323120337;25716.871415642803;42900.356494651984;43024.139517210104;43550.56449435465;43583;43742.56257437385;35979;36097.81951090228;36239.637603623625;36493;36962;36275.093122672144;36295.45556816597;36456;36629.63370366262;36771.26457470889;36201;36213.27573448569;36432.27135457223;36849.81575092107;37843.432348514245;28636.57045144283;29241.268968275963;29404.85297573584;29518.409631806815;29539.85230073836;23178.53642927166;23253;23488.765112348658;23555.175568855007;23667 04:36:02 INFO - PROCESS | 28604 | |2;jquery.html;365.1473808656787;366.3515577427951;367.89882782234884;371.19265597325824;377.6789728730581;16097;16751;17861.285548578042;17901.104944752777;17975.37086201983;16510.917445412786;16545.338186472527;17681.11594420277;17689.55776105598;17729.46811595654;5016.2224855147515;5171.836336824222;5203.349581302337;5209.635325527214;5210.114280572293;3712.3317802795486;5067.113255180348;5546.611737178399;5906.11408288758;5915.852103697399;5825.8834823303505;5843.18195452637;5844.64932104073;5873.500752436048;5877.7355019024035;5555.111182210847;5924.259467566576;5939.2575928009;5943.88112237755;5955.40445955401;4404.559544045602;5194.065068287707;5238.476152384769;5247.606429517763;5267.3942496613;10899.891001089967;11067.225294229407;11079.612213572485;11150.776984460346;11156.609518666808;1825.8777490491143;1845.5293900055535;1847.048769883511;1860.125740901774;1885.1422602715868;8834.425762325429;8837.29301655866;10578.947105264424;11703.473343699554;12405.379731013414;1693.9237734301987;1694.4069575648548;1729.144073683522;1740.530056884634;1823.717323814811;67252;68344.31655683479;70434.64782676105;72494;73505.63247183783;9370.39092458988;9836.262280329003;10242.6415075472;10298.146333659863;10426.009529094725;14326.57020289393;14328.211948342732;14370.13779173253;14418.206998614967;14437.20595367244;7253.455990800711;7260.310270524292;7270.963645181846;7424.740134095281;7487.962560187273;6795.762148324785;6897.241303456616;6915.481338899603;7048.823779405453;7052.753153639598;4358.585934336233;4424.557544245614;4426.313921342133;4439.378487011821;4499.77501124949;1576.7319555675563;1610.9919450402674;1688.4512533426685;1705.3178728508449;1830.4508647405992;844.8986121665439;863.404251066762;957.2676902169845;983.5623147699348;1012.3824467075078;16577.585560360847;16694.6661066778;16800.65594752417;17069.7439538407;17353;819.6762278899802;846.5724808971553;851.9701810436729;874.5190145419994;883.7481317824389;9235.815283694423;9500.524973751284;9550.37922535033;9646.793387109723;9731.367461115005;378037;379153;380337;382900;383781;76445.23554764381;78495.60752196203;78550;80018.5999070001;81007.59496202599;926.9907300926905;928.7817362919709;933.7852293972288;941.8775559177263;951.3150531617224;14697.779533307223;14867.479638212611;14928.253587320374;14972;14991.550253492413;32594.348113038082;32830.83584582157;33143.66856331406;33897.15257118592;34594.48108278428;47178.76410618062;47266.291005635634;47436.7628161857;47586.52413475821;47642;7392.482526223328;7491.475596708178;7499.925000749922;7647.120581133241;7692.307692307719;11256;11372.658820235407;11803.940980295043;12037.879621203676;12260.877391225973;8949.821003580022;10335.896641033494;10411.167106631603;10602.151827853908;10704.983026612459;9879.012098790063;10027.749306267402;10100.54547545377;10156.949215253877;10419.166466682798;6441;7229.674664639999;10091.293609447563;10544.683659490227;10753.623623173151;7236.6019868907715;7390.815229619303;7427.554346739213;7440;7692;9420;10073.395596264247;10120.190384769348;10186;10186.847197292194 04:36:02 INFO - PROCESS | 28604 | |3;mootools.html;1320.0231828446947;1423.9288035598217;1467.4863797670816;1763.4974032400753;1804.630050839578;6817.590944543331;7672.6930922763095;7693.153753087156;7951.125376208613;7973.880391794128;7677.270659287359;7719.150893401721;7720.189380115091;7720.189380115091;7721.498102623325;2187.84685072045;2208.3706143749037;2209.359285807114;2210.45843768277;2222.3666255117296;2156.9892150539226;2173.6304828179245;2177.3903307073965;2177.738671359439;2191.9890400547974;2175.1408193763455;2198.362474882282;2198.5712786006734;2201.317591546626;2227.8106360959255;2121.596896589651;2128.787121287882;2136.722226110596;2138.8395870309787;2145.5088713344153;2122.8089471947446;2153.9784602153936;2158.3956492182215;2160.7731188225166;2162.1459523488293;7838.412119091091;7975.601219939038;7978.361731061501;7987.241212084843;7987.880181797278;4535.705179163377;4706.635075828006;4719.669623126382;4734.242521196592;4765.070811191819;2848.5299925512268;2857.7856660750317;2884.884604615813;2891;2956.8965086222092;921.0835218957113;922.6355589542161;944.7685317097355;950.2540505703059;975.4683697384942;10898.782024359547;10898.945505272502;10956.616518421817;11000.614978475794;11026.44867756617;4148.128892932518;4169.874903752892;4331.696781225284;4356.085222103394;4381.5618438155925;9263.934647515622;9285.953570232106;9297.628094876265;9389.295802814817;9395.154436100784;4667.766611669471;4701.529847015271;4704.529547045268;4704.882377940579;4705.270683044134;3635.363811333059;4147.834086636501;4258.382534532476;4278.379634952977;4279.293916503742;3752.1745216052423;3835.5013848199555;3896.2207558488417;3920.862769803043;3945.0531872351003;1270.9300988445725;1287.0861688201294;1293.95471158509;1303.4916382610788;1303.6154334471353;1121.8429419881222;1122.1471681522103;1200.6938230751102;1226.7669142862828;1259.993700031494;7388.630568471555;7413.740519081806;7544.585047822313;7553.848923021509;7771.611419429119;1077.0145317034983;1077.8437126616755;1081.691717860406;1102.4322473925934;1113.4210210690396;5551.750171242304;5715.5427565794635;5723.627964182315;5749.453801888814;5749.88500229993;9489.478078705737;9631.71104866855;10004.149647280063;10023.69928902134;10077.647282345082;9859.852102218472;9872;9877.7036688898;9908.20734341251;9930.80138397228;7451.403887688972;7526.774196774106;7588.544687318778;7615.5430674159725;7635.198304178092;7204.4956853019785;7215.8556828864175;7225.421966242583;7255.673494692646;7309.926900731138;9031.187193152386;9110.407823491718;9152.359334846496;9269.490178040003;9359.812803743751;8963.282937365126;9231.676891308773;9367.250619950524;9412.435253884514;9500.85748713756;5778.8266352009505;6436.967815160894;6463.15978922737;7224.313690199423;7538.736144234926;7492.700291988477;7513.436492262993;7553.131389890233;7566.31903128721;7594.278543538355;6663.733450661919;6811.046453496416;6856.485763567653;6898.965505172643;6997.05539752127;6820.31796820314;6822.590644561342;6893.689783959834;6922.723091076301;6956.234814170539;7015.368616824306;7075.292470752884;7152.998580198672;7181.640917954186;7252.238514956065;6615.900761488485;6619.900701489578;6678.098456708282;6686.866262674816;6688.699008544724;6706.396424321834;6744.730210791513;6763.898541521783;6807.115075040213;6818.624975626388 04:36:02 INFO - PROCESS | 28604 | |4;prototype.html;300.3212739209387;303.9878404863807;307.1430708323777;314.2222998079752;319.63082639551317;5262.289590905227;5268.578513718903;5274.966894035931;5318.228856815759;5323.201519772036;5242.737863106839;5252.290940723001;5253.423972808152;5270.92093618596;5275.8872265363425;3888.786116763577;4021.959780402188;4127.731697439672;4146.3780432935155;4146.917061658765;4107.527634322047;4112.547619761824;4142.917141657165;4148.668106551484;4154.813033413504;4070.4911886014247;4095.9385609215888;4097.405876147956;4105.3431450967855;4116.300228961084;3995.6403923646867;4001.9399709004388;4073.8574149904757;4098.8360465581345;4100.91798164035;3592.604813470516;3616.8191590420374;3622.655847694491;3626.4741612466046;3631.5823680276576;4994.850154495371;5016.44819069902;5041.344625198701;5049.949500504985;5058;4642.698224615389;4726.787294571753;4734.952650473486;4760.428748550162;4779.641526885497;5544.500994910478;5551.333839939192;5558.6942718150485;5576.776928922838;5595.461248156748;3968.3452230381954;3969.920601587981;3973.940390894139;3974.741641793274;3985.242803867256;5564.1931919871795;5768.192453056576;5854.531637469035;5866.032104702719;5895.115732640095;4028.254772867029;4029.2344454554127;4036.9596304036586;4061.329880569732;4064.248114098901;4113.4446849675505;4114.7119701621195;4121.1345617420075;4135.648469880094;4142.378643203544;4651.695920421842;4695.647826413033;4697.976510117496;4714.713364018448;4717.811287548459;5498.532624726863;5589.74846131925;5616.326040875121;5625.240592520039;5633.8309850704545;1438.3099857667198;1453.7383271011108;1457.2203870929002;1459.8175228096488;1461.335092532895;915.5834095486538;946.5125460387768;975.8145952269047;982.759223990127;993.9304248702666;4816.831410900601;4822.324874517571;4828;4851.636127290467;4853.805847766121;5658.236138121383;5669.461401166883;5674.97162514193;5679.756496183984;5686.630369026;4663.930041049387;4817.229243321051;4820.39745031871;4839.854804355875;4979.601631869442;3090.5518699788404;3101.5967924169713;3105.503119500869;3108.4870996285813;3121.71904528589;5489.258950041693;5492.395836457987;5493.862653433696;5511.696856672841;5517.282753242133;5852.970735146382;5914.2311499504785;5937.52499800015;5962.731677074542;5985.40145985398;5463.31708536433;5468.589855760754;5472.699001554873;5488.91766623501;5489.917651235155;5588.636738611977;5701.686407247641;5728.828135155952;5751.3673495916255;5756.539476841926;5635.6618602883955;5646.717664116695;5649.774009039593;5666.490015898589;5673.631213971079;5479.369872464717;5482.890342193214;5509.090999984957;5512.448755124456;5526.751296191601;3726.2920045191327;3961.2077584483795;3964.6828253739054;4020.195960807792;4052.5542190359624;5683.318001839806;5703.230063941315;5721.799737009184;5741.569382296261;5743.42565743439;5541.473560011793;5547.44525547442;5566.081596536688;5583.218349431002;5588.580856435865;5412.024611017029;5505.284313039279;5546.833594992157;5561.193626923992;5562.944370556243;5214.51386354887;5443.891122177613;5477.4796394342475;5483.369412517452;5494.450554944474;5432.538234250133;5562.471565201299;5570.805021824217;5583.74873130702;5589.077802162597;5408.026555220098;5416.4041955385665;5440.646357986719;5458.61789674719;5459.617826752089 04:36:02 INFO - PROCESS | 28604 | |5;yui.html;755.1994885421453;763.4655740981314;773.2036002916994;774.1987043410069;775.6315750018746;12141.878581214185;12379.56671516497;13511.527096551623;14056.508022219225;14097.647558811035;14155.079919805205;14211.71576568468;14236.928815355908;14250.4299828007;14263.643408914782;656.0913135307586;815.9836803263946;829.0217543298905;829.4069740135802;829.4732844643635;798.5687728626534;814.9266566009057;820.5938060659981;821.289584509401;824.4640983360804;848.9915100848974;851.1403482482706;854.4574195385912;855.8459477294084;858.635080090962;843.7173546861809;847.6058632735777;851.6678495386835;851.812601227732;852.7058164933088;619.1023016625866;620.4292051312804;622.7197761007565;623.1711823275033;624.5128799536369;13097;13111.082224244306;13216.140950838164;13240.801387979189;13242.73514529704;12321.075919305998;12364.319962402154;12398;12585.433655485525;12597.307148106851;9639.373440726331;9878.802423951482;9960.402375857471;9967.152792012688;9995.850062249072;3275.918102047468;3319.7257183922407;3321.0534997525588;3345.280764635615;3359.2945481448924;46666.30000549994;47019.764901175615;47558.762206189094;47800;47812;9350.111739384747;9368.718938431857;9515.952420237993;9706.417614943126;10179;17012;17108.657826843395;17126;17144.914275428542;17192.398266060878;6979.162500499972;7042.683079261343;7086.858262834715;7104.606916833088;7131.037309963089;3864.0533069397616;3887.7861717605238;3910.7458015228917;3962.0491082140657;4005.459262999516;3025.7579393648457;3170.9207269817975;3173.381190667844;3206.5350524173864;3209.5988001499813;541.5829811045473;564.8531381840751;566.2101368590793;576.7462316580775;577.2149876168407;627.2942939193407;629.6757170057424;631.766246488793;637.073058699591;655.0926966151914;7811.726589569338;8059.5164290142775;8152.592370381457;8195;8352.874706879402;631.7378288010516;637.3721883944311;648.7469886744079;660.5442244851038;672.0557616548757;3847.9230415391535;3898.083950271684;3921.6078392160557;3931.724779265481;4027.1140349123148;52090.21864672033;53547;54241;54279.72860135674;54470.45529544654;46817.531824681995;46843.76578117088;47067.76466117716;47070.76464617655;47328;42359.57640423618;43407.56592434035;43860;44141;44309.77845110754;7603.505772124794;7778.261065198797;7833.216678332121;7876.960615196887;7941.364690824836;30031.849840750656;30171.245718857204;30252.84873575618;30299.697003029687;30874.845625772625;35156.296874062886;36927;39048.41427378648;40179;40667.3899891496;9599.664011759834;9834.508274586098;9843.360181588174;9970.451625160396;10230.335028223142;10944.835827462754;11177.88822111801;11234.3259404436;11277.154213433862;11446.885531144582;11147.386893720923;11336.716582085513;11339.773204535699;11341.886581134413;11800.17398782077;11000;11026.228164028762;11213.327200368005;11363.715907102389;11578.184273769306;10592.417417042137;10799.352038877692;11132.944335278271;11487.023602993839;11496.597619083292;9450.209539014333;9775.853362199716;9777.560009799718;9914;9994.950025249827;9364;9375.624975000923;10190.184785217312;10222.744431388977;10241.07830295277 04:36:02 INFO - PROCESS | 28604 | __end_tp_report 04:36:02 INFO - PROCESS | 28604 | __start_cc_report 04:36:02 INFO - PROCESS | 28604 | _x_x_mozilla_cycle_collect,384 04:36:02 INFO - PROCESS | 28604 | __end_cc_report 04:36:02 INFO - PROCESS | 28604 | __startTimestamp1460115362162__endTimestamp 04:36:02 INFO - PROCESS | 28604 | 04:36:02 INFO - PROCESS | 28604 | ------- Summary: start ------- 04:36:02 INFO - PROCESS | 28604 | Number of tests: 6 04:36:02 INFO - PROCESS | 28604 | 04:36:02 INFO - PROCESS | 28604 | [#0] dojo.html Cycles:165 Average:4679.69 Median:4807.28 stddev:480.29 (10.0%) stddev-sans-first:453.82 04:36:02 INFO - PROCESS | 28604 | Values: 2621.7 2706.4 2731.0 2744.1 2753.5 4613.0 4616.3 4617.9 4652.2 4660.8 4574.5 4652.8 4656.3 4702.6 4703.1 4218.4 4327.5 4389.4 4425.4 4449.0 4414.8 4426.9 4459.2 4470.9 4499.1 4193.3 4298.4 4439.0 4466.8 4485.3 4268.0 4271.6 4273.0 4311.5 4314.5 4226.0 4244.7 4273.5 4285.0 4291.0 4481.9 4522.8 4642.5 4720.3 4735.8 5007.4 5007.9 5028.4 5033.5 5081.9 5039.6 5071.3 5092.7 5094.6 5094.8 4579.2 4680.8 4753.8 4759.7 4810.2 5165.7 5188.6 5195.1 5195.2 5218.2 4814.0 4937.0 4967.9 4980.4 4982.0 5033.4 5066.6 5096.2 5119.8 5138.9 5008.7 5035.1 5044.4 5047.1 5078.1 4871.2 5005.6 5008.3 5013.2 5031.5 4194.8 4302.8 4308.3 4358.9 4371.8 3731.4 3773.3 3787.5 3806.4 3855.6 4327.2 4378.7 4403.3 4423.1 4469.8 5099.5 5111.1 5111.7 5114.8 5155.5 4408.9 4424.8 4427.5 4447.5 4484.1 4510.0 4598.6 4623.0 4627.4 4686.9 4800.4 4804.0 4807.3 4841.5 4862.1 5073.0 5082.2 5091.1 5092.6 5093.7 4673.4 4810.5 4849.9 4870.6 4897.6 5016.2 5017.9 5026.1 5031.0 5088.6 5108.6 5111.5 5114.6 5119.6 5127.1 4771.4 4881.7 4927.8 4940.0 4962.9 4902.8 4931.7 4940.5 4944.8 4998.9 4720.2 4867.8 4868.8 4878.1 4888.4 4827.6 4922.6 4936.1 5020.6 5029.9 4777.3 4799.6 4805.2 4826.8 4833.1 04:36:02 INFO - PROCESS | 28604 | 04:36:02 INFO - PROCESS | 28604 | [#1] ext.html Cycles:180 Average:40104.11 Median:33103.75 stddev:70180.16 (212.0%) stddev-sans-first:70314.31 04:36:02 INFO - PROCESS | 28604 | Values: 584.8 592.8 601.7 613.1 631.8 31820.4 32741.5 32759.0 32803.2 32808.0 32400.2 32995.8 33150.7 33276.8 33501.8 7385.2 7610.1 7656.4 7665.2 7673.1 7624.8 7658.3 7700.5 7717.4 7741.8 7672.5 7675.4 7676.5 7722.7 7735.8 7574.9 7615.7 7664.3 7687.2 7690.7 7599.0 7663.6 7713.3 7725.4 7729.1 29361.0 34508.7 34725.5 34815.1 34845.5 2928.5 2990.2 3019.8 3398.5 3556.1 23868.9 24065.3 24306.3 24866.6 24921.4 3301.0 3344.9 3370.3 3388.4 3473.2 184060.0 186170.0 186319.0 186571.0 186824.0 31516.5 31781.8 31852.0 33056.8 33919.5 31621.5 31623.4 31665.0 31683.2 31751.8 13285.5 13401.5 13478.8 13493.5 13506.1 10895.7 11007.8 11063.2 11075.7 11093.4 8052.7 8056.9 8062.0 8142.3 8143.8 3211.7 3215.4 3233.2 3257.3 3303.4 911.5 936.3 949.6 972.0 996.7 27269.6 28358.9 28422.0 28508.3 28597.1 1006.6 1008.5 1042.5 1058.7 1063.3 14945.7 15427.9 15524.9 15575.8 15625.2 333818.0 340345.0 340842.0 341607.0 342022.0 48467.0 49462.0 49632.8 49645.8 49679.0 1203.7 1221.9 1258.1 1270.5 1278.8 26100.5 27490.7 27744.7 27765.7 27786.4 41613.4 41816.8 42066.0 42090.8 42160.8 251377.0 251806.0 251991.0 253122.0 253132.0 25209.5 25357.6 25414.6 25689.2 25716.9 42900.4 43024.1 43550.6 43583.0 43742.6 35979.0 36097.8 36239.6 36493.0 36962.0 36275.1 36295.5 36456.0 36629.6 36771.3 36201.0 36213.3 36432.3 36849.8 37843.4 28636.6 29241.3 29404.9 29518.4 29539.9 23178.5 23253.0 23488.8 23555.2 23667.0 04:36:02 INFO - PROCESS | 28604 | 04:36:02 INFO - PROCESS | 28604 | [#2] jquery.html Cycles:180 Average:23697.81 Median:4425.44 stddev:62990.43 (1423.4%) stddev-sans-first:63142.77 04:36:02 INFO - PROCESS | 28604 | Values: 365.1 366.4 367.9 371.2 377.7 16097.0 16751.0 17861.3 17901.1 17975.4 16510.9 16545.3 17681.1 17689.6 17729.5 5016.2 5171.8 5203.3 5209.6 5210.1 3712.3 5067.1 5546.6 5906.1 5915.9 5825.9 5843.2 5844.6 5873.5 5877.7 5555.1 5924.3 5939.3 5943.9 5955.4 4404.6 5194.1 5238.5 5247.6 5267.4 10899.9 11067.2 11079.6 11150.8 11156.6 1825.9 1845.5 1847.0 1860.1 1885.1 8834.4 8837.3 10578.9 11703.5 12405.4 1693.9 1694.4 1729.1 1740.5 1823.7 67252.0 68344.3 70434.6 72494.0 73505.6 9370.4 9836.3 10242.6 10298.1 10426.0 14326.6 14328.2 14370.1 14418.2 14437.2 7253.5 7260.3 7271.0 7424.7 7488.0 6795.8 6897.2 6915.5 7048.8 7052.8 4358.6 4424.6 4426.3 4439.4 4499.8 1576.7 1611.0 1688.5 1705.3 1830.5 844.9 863.4 957.3 983.6 1012.4 16577.6 16694.7 16800.7 17069.7 17353.0 819.7 846.6 852.0 874.5 883.7 9235.8 9500.5 9550.4 9646.8 9731.4 378037.0 379153.0 380337.0 382900.0 383781.0 76445.2 78495.6 78550.0 80018.6 81007.6 927.0 928.8 933.8 941.9 951.3 14697.8 14867.5 14928.3 14972.0 14991.6 32594.3 32830.8 33143.7 33897.2 34594.5 47178.8 47266.3 47436.8 47586.5 47642.0 7392.5 7491.5 7499.9 7647.1 7692.3 11256.0 11372.7 11803.9 12037.9 12260.9 8949.8 10335.9 10411.2 10602.2 10705.0 9879.0 10027.7 10100.5 10156.9 10419.2 6441.0 7229.7 10091.3 10544.7 10753.6 7236.6 7390.8 7427.6 7440.0 7692.0 9420.0 10073.4 10120.2 10186.0 10186.8 04:36:02 INFO - PROCESS | 28604 | 04:36:02 INFO - PROCESS | 28604 | [#3] mootools.html Cycles:180 Average:5550.72 Median:6539.53 stddev:2964.96 (45.3%) stddev-sans-first:2956.23 04:36:02 INFO - PROCESS | 28604 | Values: 1320.0 1423.9 1467.5 1763.5 1804.6 6817.6 7672.7 7693.2 7951.1 7973.9 7677.3 7719.2 7720.2 7720.2 7721.5 2187.8 2208.4 2209.4 2210.5 2222.4 2157.0 2173.6 2177.4 2177.7 2192.0 2175.1 2198.4 2198.6 2201.3 2227.8 2121.6 2128.8 2136.7 2138.8 2145.5 2122.8 2154.0 2158.4 2160.8 2162.1 7838.4 7975.6 7978.4 7987.2 7987.9 4535.7 4706.6 4719.7 4734.2 4765.1 2848.5 2857.8 2884.9 2891.0 2956.9 921.1 922.6 944.8 950.3 975.5 10898.8 10898.9 10956.6 11000.6 11026.4 4148.1 4169.9 4331.7 4356.1 4381.6 9263.9 9286.0 9297.6 9389.3 9395.2 4667.8 4701.5 4704.5 4704.9 4705.3 3635.4 4147.8 4258.4 4278.4 4279.3 3752.2 3835.5 3896.2 3920.9 3945.1 1270.9 1287.1 1294.0 1303.5 1303.6 1121.8 1122.1 1200.7 1226.8 1260.0 7388.6 7413.7 7544.6 7553.8 7771.6 1077.0 1077.8 1081.7 1102.4 1113.4 5551.8 5715.5 5723.6 5749.5 5749.9 9489.5 9631.7 10004.1 10023.7 10077.6 9859.9 9872.0 9877.7 9908.2 9930.8 7451.4 7526.8 7588.5 7615.5 7635.2 7204.5 7215.9 7225.4 7255.7 7309.9 9031.2 9110.4 9152.4 9269.5 9359.8 8963.3 9231.7 9367.3 9412.4 9500.9 5778.8 6437.0 6463.2 7224.3 7538.7 7492.7 7513.4 7553.1 7566.3 7594.3 6663.7 6811.0 6856.5 6899.0 6997.1 6820.3 6822.6 6893.7 6922.7 6956.2 7015.4 7075.3 7153.0 7181.6 7252.2 6615.9 6619.9 6678.1 6686.9 6688.7 6706.4 6744.7 6763.9 6807.1 6818.6 04:36:02 INFO - PROCESS | 28604 | 04:36:02 INFO - PROCESS | 28604 | [#4] prototype.html Cycles:180 Average:4615.38 Median:5269.75 stddev:1344.67 (25.5%) stddev-sans-first:1308.86 04:36:02 INFO - PROCESS | 28604 | Values: 300.3 304.0 307.1 314.2 319.6 5262.3 5268.6 5275.0 5318.2 5323.2 5242.7 5252.3 5253.4 5270.9 5275.9 3888.8 4022.0 4127.7 4146.4 4146.9 4107.5 4112.5 4142.9 4148.7 4154.8 4070.5 4095.9 4097.4 4105.3 4116.3 3995.6 4001.9 4073.9 4098.8 4100.9 3592.6 3616.8 3622.7 3626.5 3631.6 4994.9 5016.4 5041.3 5049.9 5058.0 4642.7 4726.8 4735.0 4760.4 4779.6 5544.5 5551.3 5558.7 5576.8 5595.5 3968.3 3969.9 3973.9 3974.7 3985.2 5564.2 5768.2 5854.5 5866.0 5895.1 4028.3 4029.2 4037.0 4061.3 4064.2 4113.4 4114.7 4121.1 4135.6 4142.4 4651.7 4695.6 4698.0 4714.7 4717.8 5498.5 5589.7 5616.3 5625.2 5633.8 1438.3 1453.7 1457.2 1459.8 1461.3 915.6 946.5 975.8 982.8 993.9 4816.8 4822.3 4828.0 4851.6 4853.8 5658.2 5669.5 5675.0 5679.8 5686.6 4663.9 4817.2 4820.4 4839.9 4979.6 3090.6 3101.6 3105.5 3108.5 3121.7 5489.3 5492.4 5493.9 5511.7 5517.3 5853.0 5914.2 5937.5 5962.7 5985.4 5463.3 5468.6 5472.7 5488.9 5489.9 5588.6 5701.7 5728.8 5751.4 5756.5 5635.7 5646.7 5649.8 5666.5 5673.6 5479.4 5482.9 5509.1 5512.4 5526.8 3726.3 3961.2 3964.7 4020.2 4052.6 5683.3 5703.2 5721.8 5741.6 5743.4 5541.5 5547.4 5566.1 5583.2 5588.6 5412.0 5505.3 5546.8 5561.2 5562.9 5214.5 5443.9 5477.5 5483.4 5494.5 5432.5 5562.5 5570.8 5583.7 5589.1 5408.0 5416.4 5440.6 5458.6 5459.6 04:36:02 INFO - PROCESS | 28604 | 04:36:02 INFO - PROCESS | 28604 | [#5] yui.html Cycles:180 Average:13015.69 Median:47199.38 stddev:14728.65 (31.2%) stddev-sans-first:14741.19 04:36:02 INFO - PROCESS | 28604 | Values: 755.2 763.5 773.2 774.2 775.6 12141.9 12379.6 13511.5 14056.5 14097.6 14155.1 14211.7 14236.9 14250.4 14263.6 656.1 816.0 829.0 829.4 829.5 798.6 814.9 820.6 821.3 824.5 849.0 851.1 854.5 855.8 858.6 843.7 847.6 851.7 851.8 852.7 619.1 620.4 622.7 623.2 624.5 13097.0 13111.1 13216.1 13240.8 13242.7 12321.1 12364.3 12398.0 12585.4 12597.3 9639.4 9878.8 9960.4 9967.2 9995.9 3275.9 3319.7 3321.1 3345.3 3359.3 46666.3 47019.8 47558.8 47800.0 47812.0 9350.1 9368.7 9516.0 9706.4 10179.0 17012.0 17108.7 17126.0 17144.9 17192.4 6979.2 7042.7 7086.9 7104.6 7131.0 3864.1 3887.8 3910.7 3962.0 4005.5 3025.8 3170.9 3173.4 3206.5 3209.6 541.6 564.9 566.2 576.7 577.2 627.3 629.7 631.8 637.1 655.1 7811.7 8059.5 8152.6 8195.0 8352.9 631.7 637.4 648.7 660.5 672.1 3847.9 3898.1 3921.6 3931.7 4027.1 52090.2 53547.0 54241.0 54279.7 54470.5 46817.5 46843.8 47067.8 47070.8 47328.0 42359.6 43407.6 43860.0 44141.0 44309.8 7603.5 7778.3 7833.2 7877.0 7941.4 30031.8 30171.2 30252.8 30299.7 30874.8 35156.3 36927.0 39048.4 40179.0 40667.4 9599.7 9834.5 9843.4 9970.5 10230.3 10944.8 11177.9 11234.3 11277.2 11446.9 11147.4 11336.7 11339.8 11341.9 11800.2 11000.0 11026.2 11213.3 11363.7 11578.2 10592.4 10799.4 11132.9 11487.0 11496.6 9450.2 9775.9 9777.6 9914.0 9995.0 9364.0 9375.6 10190.2 10222.7 10241.1 04:36:02 INFO - PROCESS | 28604 | -------- Summary: end -------- 04:36:02 INFO - PROCESS | 28604 | 04:36:02 INFO - TEST-INFO | 28604: exit 0 04:36:02 INFO - TEST-OK | dromaeo_css | took 1114587ms 04:36:02 INFO - TEST-START | kraken 04:36:02 INFO - operating with platform_type : linux_ 04:36:02 INFO - Initialising browser for kraken test... 04:36:02 INFO - TEST-INFO | started process 28843 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1l6Njc/profile http://localhost:60551/getInfo.html) 04:36:06 INFO - PROCESS | 28843 | 04:36:06 INFO - PROCESS | 28843 | (process:28910): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:36:06 INFO - PROCESS | 28843 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 04:36:07 INFO - PROCESS | 28843 | __metrics Screen width/height:1600/1200 04:36:07 INFO - PROCESS | 28843 | colorDepth:24 04:36:07 INFO - PROCESS | 28843 | Browser inner width/height: 1024/697 04:36:07 INFO - PROCESS | 28843 | __metrics 04:36:07 ERROR - PROCESS | 28843 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 04:36:08 INFO - TEST-INFO | 28843: exit 0 04:36:08 INFO - Browser initialized. 04:36:08 INFO - Running cycle 1/1 for kraken test... 04:36:08 INFO - TEST-INFO | started process 28961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1l6Njc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:36:10 INFO - PROCESS | 28961 | 04:36:10 INFO - PROCESS | 28961 | (process:29022): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:36:20 INFO - PROCESS | 28961 | RSS: Main: 163799040 04:36:20 INFO - PROCESS | 28961 | 04:36:23 INFO - PROCESS | 28961 | Cycle 1(1): loaded http://localhost:60551/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60551/tests/kraken/driver.html?testName=audio-beat-detection) 04:36:23 INFO - PROCESS | 28961 | RSS: Main: 167759872 04:36:23 INFO - PROCESS | 28961 | 04:36:26 INFO - PROCESS | 28961 | Cycle 1(1): loaded http://localhost:60551/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60551/tests/kraken/driver.html?testName=audio-dft) 04:36:27 INFO - PROCESS | 28961 | RSS: Main: 171139072 04:36:27 INFO - PROCESS | 28961 | 04:36:30 INFO - PROCESS | 28961 | Cycle 1(1): loaded http://localhost:60551/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60551/tests/kraken/driver.html?testName=audio-fft) 04:36:30 INFO - PROCESS | 28961 | RSS: Main: 163155968 04:36:30 INFO - PROCESS | 28961 | 04:36:32 INFO - PROCESS | 28961 | Cycle 1(1): loaded http://localhost:60551/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60551/tests/kraken/driver.html?testName=audio-oscillator) 04:36:33 INFO - PROCESS | 28961 | RSS: Main: 163708928 04:36:33 INFO - PROCESS | 28961 | 04:36:35 INFO - PROCESS | 28961 | Cycle 1(1): loaded http://localhost:60551/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60551/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:36:36 INFO - PROCESS | 28961 | RSS: Main: 164290560 04:36:36 INFO - PROCESS | 28961 | 04:36:39 INFO - PROCESS | 28961 | Cycle 1(1): loaded http://localhost:60551/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60551/tests/kraken/driver.html?testName=imaging-darkroom) 04:36:40 INFO - PROCESS | 28961 | RSS: Main: 164167680 04:36:40 INFO - PROCESS | 28961 | 04:36:43 INFO - PROCESS | 28961 | Cycle 1(1): loaded http://localhost:60551/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60551/tests/kraken/driver.html?testName=imaging-desaturate) 04:36:44 INFO - PROCESS | 28961 | RSS: Main: 161964032 04:36:44 INFO - PROCESS | 28961 | 04:36:47 INFO - PROCESS | 28961 | Cycle 1(1): loaded http://localhost:60551/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60551/tests/kraken/driver.html?testName=json-parse-financial) 04:36:47 INFO - PROCESS | 28961 | RSS: Main: 162832384 04:36:47 INFO - PROCESS | 28961 | 04:36:49 INFO - PROCESS | 28961 | Cycle 1(1): loaded http://localhost:60551/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60551/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:36:50 INFO - PROCESS | 28961 | RSS: Main: 163209216 04:36:50 INFO - PROCESS | 28961 | 04:36:52 INFO - PROCESS | 28961 | Cycle 1(1): loaded http://localhost:60551/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60551/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:36:52 INFO - PROCESS | 28961 | RSS: Main: 164188160 04:36:52 INFO - PROCESS | 28961 | 04:36:54 INFO - PROCESS | 28961 | Cycle 1(1): loaded http://localhost:60551/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60551/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:36:55 INFO - PROCESS | 28961 | RSS: Main: 163610624 04:36:55 INFO - PROCESS | 28961 | 04:36:58 INFO - PROCESS | 28961 | Cycle 1(1): loaded http://localhost:60551/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60551/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:36:58 INFO - PROCESS | 28961 | RSS: Main: 164167680 04:36:58 INFO - PROCESS | 28961 | 04:37:01 INFO - PROCESS | 28961 | Cycle 1(1): loaded http://localhost:60551/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60551/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:37:02 INFO - PROCESS | 28961 | RSS: Main: 163639296 04:37:02 INFO - PROCESS | 28961 | 04:37:04 INFO - PROCESS | 28961 | Cycle 1(1): loaded http://localhost:60551/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60551/tests/kraken/driver.html?testName=ai-astar) 04:37:04 INFO - PROCESS | 28961 | RSS: Main: 165474304 04:37:04 INFO - PROCESS | 28961 | 04:37:04 INFO - PROCESS | 28961 | __start_tp_report 04:37:04 INFO - PROCESS | 28961 | _x_x_mozilla_page_load 04:37:04 INFO - PROCESS | 28961 | _x_x_mozilla_page_load_details 04:37:04 INFO - PROCESS | 28961 | |i|pagename|runs| 04:37:04 INFO - PROCESS | 28961 | |0;ai-astar;115;108;114;115;115;126;115;114;113;114 04:37:04 INFO - PROCESS | 28961 | |1;audio-beat-detection;164;140;162;196;136;160;161;141;180;141 04:37:04 INFO - PROCESS | 28961 | |2;audio-dft;163;162;160;161;163;176;164;162;165;162 04:37:04 INFO - PROCESS | 28961 | |3;audio-fft;73;74;75;73;72;73;75;144;77;78 04:37:04 INFO - PROCESS | 28961 | |4;audio-oscillator;92;93;132;96;94;96;140;92;94;136 04:37:04 INFO - PROCESS | 28961 | |5;imaging-gaussian-blur;117;119;117;118;117;117;118;118;117;118 04:37:04 INFO - PROCESS | 28961 | |6;imaging-darkroom;147;147;148;146;146;146;147;149;146;150 04:37:04 INFO - PROCESS | 28961 | |7;imaging-desaturate;96;96;98;96;96;96;96;96;96;96 04:37:04 INFO - PROCESS | 28961 | |8;json-parse-financial;71;67;66;67;69;66;66;66;70;64 04:37:04 INFO - PROCESS | 28961 | |9;json-stringify-tinderbox;63;64;65;64;65;64;65;64;63;65 04:37:04 INFO - PROCESS | 28961 | |10;stanford-crypto-aes;85;94;86;86;85;85;85;93;86;86 04:37:04 INFO - PROCESS | 28961 | |11;stanford-crypto-ccm;140;140;144;146;143;153;142;141;151;138 04:37:04 INFO - PROCESS | 28961 | |12;stanford-crypto-pbkdf2;180;170;171;172;174;178;171;172;174;171 04:37:04 INFO - PROCESS | 28961 | |13;stanford-crypto-sha256-iterative;73;74;73;72;71;71;72;71;70;83 04:37:04 INFO - PROCESS | 28961 | __end_tp_report 04:37:04 INFO - PROCESS | 28961 | __start_cc_report 04:37:04 INFO - PROCESS | 28961 | _x_x_mozilla_cycle_collect,939 04:37:04 INFO - PROCESS | 28961 | __end_cc_report 04:37:04 INFO - PROCESS | 28961 | __startTimestamp1460115424561__endTimestamp 04:37:04 INFO - PROCESS | 28961 | 04:37:04 INFO - PROCESS | 28961 | ------- Summary: start ------- 04:37:04 INFO - PROCESS | 28961 | Number of tests: 14 04:37:04 INFO - PROCESS | 28961 | 04:37:04 INFO - PROCESS | 28961 | [#0] ai-astar Cycles:10 Average:114.90 Median:115.00 stddev:4.43 (3.9%) stddev-sans-first:4.70 04:37:04 INFO - PROCESS | 28961 | Values: 115.0 108.0 114.0 115.0 115.0 126.0 115.0 114.0 113.0 114.0 04:37:04 INFO - PROCESS | 28961 | 04:37:04 INFO - PROCESS | 28961 | [#1] audio-beat-detection Cycles:10 Average:158.10 Median:161.50 stddev:19.38 (12.0%) stddev-sans-first:20.43 04:37:04 INFO - PROCESS | 28961 | Values: 164.0 140.0 162.0 196.0 136.0 160.0 161.0 141.0 180.0 141.0 04:37:04 INFO - PROCESS | 28961 | 04:37:04 INFO - PROCESS | 28961 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:4.52 (2.8%) stddev-sans-first:4.78 04:37:04 INFO - PROCESS | 28961 | Values: 163.0 162.0 160.0 161.0 163.0 176.0 164.0 162.0 165.0 162.0 04:37:04 INFO - PROCESS | 28961 | 04:37:04 INFO - PROCESS | 28961 | [#3] audio-fft Cycles:10 Average:81.40 Median:74.50 stddev:22.08 (29.6%) stddev-sans-first:23.21 04:37:04 INFO - PROCESS | 28961 | Values: 73.0 74.0 75.0 73.0 72.0 73.0 75.0 144.0 77.0 78.0 04:37:04 INFO - PROCESS | 28961 | 04:37:04 INFO - PROCESS | 28961 | [#4] audio-oscillator Cycles:10 Average:106.50 Median:93.50 stddev:20.49 (21.9%) stddev-sans-first:21.05 04:37:04 INFO - PROCESS | 28961 | Values: 92.0 93.0 132.0 96.0 94.0 96.0 140.0 92.0 94.0 136.0 04:37:04 INFO - PROCESS | 28961 | 04:37:04 INFO - PROCESS | 28961 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 04:37:04 INFO - PROCESS | 28961 | Values: 117.0 119.0 117.0 118.0 117.0 117.0 118.0 118.0 117.0 118.0 04:37:04 INFO - PROCESS | 28961 | 04:37:04 INFO - PROCESS | 28961 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.40 (1.0%) stddev-sans-first:1.48 04:37:04 INFO - PROCESS | 28961 | Values: 147.0 147.0 148.0 146.0 146.0 146.0 147.0 149.0 146.0 150.0 04:37:04 INFO - PROCESS | 28961 | 04:37:04 INFO - PROCESS | 28961 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:37:04 INFO - PROCESS | 28961 | Values: 96.0 96.0 98.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 04:37:04 INFO - PROCESS | 28961 | 04:37:04 INFO - PROCESS | 28961 | [#8] json-parse-financial Cycles:10 Average:67.20 Median:67.00 stddev:2.15 (3.2%) stddev-sans-first:1.79 04:37:04 INFO - PROCESS | 28961 | Values: 71.0 67.0 66.0 67.0 69.0 66.0 66.0 66.0 70.0 64.0 04:37:04 INFO - PROCESS | 28961 | 04:37:04 INFO - PROCESS | 28961 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 04:37:04 INFO - PROCESS | 28961 | Values: 63.0 64.0 65.0 64.0 65.0 64.0 65.0 64.0 63.0 65.0 04:37:04 INFO - PROCESS | 28961 | 04:37:04 INFO - PROCESS | 28961 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:86.00 stddev:3.41 (4.0%) stddev-sans-first:3.54 04:37:04 INFO - PROCESS | 28961 | Values: 85.0 94.0 86.0 86.0 85.0 85.0 85.0 93.0 86.0 86.0 04:37:04 INFO - PROCESS | 28961 | 04:37:04 INFO - PROCESS | 28961 | [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:143.50 stddev:4.89 (3.4%) stddev-sans-first:4.99 04:37:04 INFO - PROCESS | 28961 | Values: 140.0 140.0 144.0 146.0 143.0 153.0 142.0 141.0 151.0 138.0 04:37:04 INFO - PROCESS | 28961 | 04:37:04 INFO - PROCESS | 28961 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:173.00 stddev:3.30 (1.9%) stddev-sans-first:2.46 04:37:04 INFO - PROCESS | 28961 | Values: 180.0 170.0 171.0 172.0 174.0 178.0 171.0 172.0 174.0 171.0 04:37:04 INFO - PROCESS | 28961 | 04:37:04 INFO - PROCESS | 28961 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:72.50 stddev:3.71 (5.1%) stddev-sans-first:3.94 04:37:04 INFO - PROCESS | 28961 | Values: 73.0 74.0 73.0 72.0 71.0 71.0 72.0 71.0 70.0 83.0 04:37:04 INFO - PROCESS | 28961 | -------- Summary: end -------- 04:37:04 INFO - PROCESS | 28961 | 04:37:05 INFO - TEST-INFO | 28961: exit 0 04:37:05 INFO - TEST-OK | kraken | took 62626ms 04:37:05 INFO - SUITE-END | took 1177s 04:37:05 INFO - Completed test suite (00:19:37) 04:37:05 INFO - javascript benchmark 04:37:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2621.7378262173784, 2706.404590989983, 2731.0, 2744.08073295446, 2753.4630747004344, 4612.953870461294, 4616.33063205835, 4617.868622187564, 4652.232381657031, 4660.7902644381, 4574.451065872092, 4652.8138874444985, 4656.348111264426, 4702.553257440538, 4703.129920964615, 4218.430511880895, 4327.502337231212, 4389.363542286366, 4425.424694789689, 4448.95449569351, 4414.8300700314285, 4426.867193984185, 4459.152760975404, 4470.865874023784, 4499.055198408339, 4193.287141186006, 4298.441202643637, 4439.045605194882, 4466.821327146927, 4485.327200919855, 4267.997020700133, 4271.572842715735, 4273.0, 4311.504177019651, 4314.503832059322, 4225.985763416788, 4244.702870799046, 4273.50854651716, 4284.971606814373, 4290.978545107255, 4481.865544033684, 4522.751248681321, 4642.489326174118, 4720.268358404453, 4735.763211839429, 5007.399112106534, 5007.949920500785, 5028.421731500851, 5033.496650334974, 5081.898362032739, 5039.596832253411, 5071.340725705634, 5092.668976516515, 5094.6433749637545, 5094.77725345918, 4579.152856721484, 4680.789364478606, 4753.762311884392, 4759.714417134983, 4810.206315957827, 5165.690058596496, 5188.636795424284, 5195.064888320138, 5195.19474481456, 5218.165093585008, 4814.037192561502, 4936.975315123474, 4967.925481117786, 4980.377452818398, 4981.975090124526, 5033.446320904697, 5066.594672426197, 5096.235564665256, 5119.769610367543, 5138.87152821175, 5008.699478031257, 5035.144025515671, 5044.419891712427, 5047.066292735855, 5078.13671675816, 4871.244957031595, 5005.5745261653165, 5008.273800298936, 5013.172826483589, 5031.471695471922, 4194.769287689145, 4302.827886884552, 4308.310670292738, 4358.912821743547, 4371.825126994948, 3731.402975523903, 3773.339665558571, 3787.4697542344093, 3806.390977443651, 3855.5951625078965, 4327.156204540084, 4378.671599630041, 4403.339499075164, 4423.071155057474, 4469.7988590513505, 5099.490050994871, 5111.105556527667, 5111.718855462911, 5114.795408183631, 5155.510226528474, 4408.911821763547, 4424.823007079745, 4427.5351088135285, 4447.510773814878, 4484.080763443486, 4509.954900450954, 4598.632109431237, 4623.029163875556, 4627.3521706961055, 4686.906261874811, 4800.4479484859685, 4803.975980120077, 4807.278908163804, 4841.515848415131, 4862.100511405401, 5072.9746351268, 5082.2122571001555, 5091.0836049511445, 5092.592592592509, 5093.745312734422, 4673.369095172108, 4810.470848206624, 4849.927251091166, 4870.561649451566, 4897.608191344755, 5016.197408414636, 5017.949820501748, 5026.070177017264, 5031.0441016206805, 5088.59291256706, 5108.59131269505, 5111.46329635383, 5114.616403769806, 5119.641625086358, 5127.077126117335, 4771.403574553181, 4881.658283920092, 4927.827526036572, 4939.950600494093, 4962.925556116589, 4902.754862256944, 4931.72875491837, 4940.530649588283, 4944.777485013111, 4998.900021999612, 4720.173969555245, 4867.80528778859, 4868.780904859219, 4878.0975519529, 4888.437829649636, 4827.589654879374, 4922.630802689741, 4936.136176169228, 5020.598352131894, 5029.874253143701, 4777.3072904429355, 4799.640026998059, 4805.207140821725, 4826.758662066953, 4833.05755377698], "value": 4650.181502078331, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.8099367705494, 592.7984485275006, 601.6540489218701, 613.0711971363384, 631.8483563944654, 31820.36359272816, 32741.50887736683, 32759.0, 32803.179920502, 32808.0, 32400.18999525013, 32995.83502082486, 33150.66849331506, 33276.833615831885, 33501.83249083757, 7385.150707668619, 7610.124835643916, 7656.425768067417, 7665.1951545087795, 7673.117591476968, 7624.771256862303, 7658.2724641159, 7700.4609677322605, 7717.382609391263, 7741.845163096735, 7672.46292759507, 7675.385969122484, 7676.46264761467, 7722.652480638357, 7735.845283094335, 7574.886376704354, 7615.7334493292465, 7664.348530374925, 7687.231276872296, 7690.730824421146, 7598.962005189994, 7663.6168191590195, 7713.267239612228, 7725.4205934554575, 7729.149793522708, 29361.0, 34508.65491345105, 34725.47911781325, 34815.129621759406, 34845.47731784, 2928.502154633696, 2990.2374894402005, 3019.758419326449, 3398.507216453625, 3556.0754203906913, 23868.88065559661, 24065.278041658778, 24306.27081187567, 24866.627000595006, 24921.376965575826, 3300.96699033009, 3344.899653010389, 3370.3427831572853, 3388.40702876998, 3473.166440054394, 184060.0, 186170.0, 186319.0, 186571.0, 186824.0, 31516.527252091237, 31781.84109079486, 31852.0, 33056.83471582627, 33919.49120763191, 31621.525677114863, 31623.36753264922, 31665.0, 31683.20791980219, 31751.84124079411, 13285.535006274735, 13401.53094641683, 13478.797818032737, 13493.460261589427, 13506.122102063531, 10895.727606809734, 11007.834882476769, 11063.225574209728, 11075.667729968114, 11093.389863557582, 8052.677892884219, 8056.879146812803, 8062.0, 8142.267195952392, 8143.837123257502, 3211.6627754085484, 3215.3730022645827, 3233.224026233687, 3257.299680568689, 3303.405387030358, 911.5168960450972, 936.2743873498093, 949.5537097564134, 972.027972027972, 996.6960077176531, 27269.590956135675, 28358.85820570884, 28422.0, 28508.287292817844, 28597.14208573746, 1006.6074231049896, 1008.4503945349802, 1042.5152304178441, 1058.687687132298, 1063.3460421840666, 14945.70108597822, 15427.922860385626, 15524.913256072192, 15575.766363504557, 15625.218739063, 333818.0, 340345.0, 340842.0, 341607.0, 342022.0, 48467.0, 49462.0, 49632.75183624059, 49645.75177124091, 49679.0, 1203.6810245285008, 1221.859486159103, 1258.08160043169, 1270.4600544768437, 1278.7889998150388, 26100.477990440464, 27490.725092749617, 27744.722552774212, 27765.72234277712, 27786.44427111487, 41613.37579936364, 41816.79091604644, 42066.0, 42090.7895460533, 42160.789196053825, 251377.0, 251806.0, 251991.0, 253122.0, 253132.0, 25209.495810084063, 25357.61963570511, 25414.618780718672, 25689.229323120337, 25716.871415642803, 42900.356494651984, 43024.139517210104, 43550.56449435465, 43583.0, 43742.56257437385, 35979.0, 36097.81951090228, 36239.637603623625, 36493.0, 36962.0, 36275.093122672144, 36295.45556816597, 36456.0, 36629.63370366262, 36771.26457470889, 36201.0, 36213.27573448569, 36432.27135457223, 36849.81575092107, 37843.432348514245, 28636.57045144283, 29241.268968275963, 29404.85297573584, 29518.409631806815, 29539.85230073836, 23178.53642927166, 23253.0, 23488.765112348658, 23555.175568855007, 23667.0], "value": 15684.02712168338, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.1473808656787, 366.3515577427951, 367.89882782234884, 371.19265597325824, 377.6789728730581, 16097.0, 16751.0, 17861.285548578042, 17901.104944752777, 17975.37086201983, 16510.917445412786, 16545.338186472527, 17681.11594420277, 17689.55776105598, 17729.46811595654, 5016.2224855147515, 5171.836336824222, 5203.349581302337, 5209.635325527214, 5210.114280572293, 3712.3317802795486, 5067.113255180348, 5546.611737178399, 5906.11408288758, 5915.852103697399, 5825.8834823303505, 5843.18195452637, 5844.64932104073, 5873.500752436048, 5877.7355019024035, 5555.111182210847, 5924.259467566576, 5939.2575928009, 5943.88112237755, 5955.40445955401, 4404.559544045602, 5194.065068287707, 5238.476152384769, 5247.606429517763, 5267.3942496613, 10899.891001089967, 11067.225294229407, 11079.612213572485, 11150.776984460346, 11156.609518666808, 1825.8777490491143, 1845.5293900055535, 1847.048769883511, 1860.125740901774, 1885.1422602715868, 8834.425762325429, 8837.29301655866, 10578.947105264424, 11703.473343699554, 12405.379731013414, 1693.9237734301987, 1694.4069575648548, 1729.144073683522, 1740.530056884634, 1823.717323814811, 67252.0, 68344.31655683479, 70434.64782676105, 72494.0, 73505.63247183783, 9370.39092458988, 9836.262280329003, 10242.6415075472, 10298.146333659863, 10426.009529094725, 14326.57020289393, 14328.211948342732, 14370.13779173253, 14418.206998614967, 14437.20595367244, 7253.455990800711, 7260.310270524292, 7270.963645181846, 7424.740134095281, 7487.962560187273, 6795.762148324785, 6897.241303456616, 6915.481338899603, 7048.823779405453, 7052.753153639598, 4358.585934336233, 4424.557544245614, 4426.313921342133, 4439.378487011821, 4499.77501124949, 1576.7319555675563, 1610.9919450402674, 1688.4512533426685, 1705.3178728508449, 1830.4508647405992, 844.8986121665439, 863.404251066762, 957.2676902169845, 983.5623147699348, 1012.3824467075078, 16577.585560360847, 16694.6661066778, 16800.65594752417, 17069.7439538407, 17353.0, 819.6762278899802, 846.5724808971553, 851.9701810436729, 874.5190145419994, 883.7481317824389, 9235.815283694423, 9500.524973751284, 9550.37922535033, 9646.793387109723, 9731.367461115005, 378037.0, 379153.0, 380337.0, 382900.0, 383781.0, 76445.23554764381, 78495.60752196203, 78550.0, 80018.5999070001, 81007.59496202599, 926.9907300926905, 928.7817362919709, 933.7852293972288, 941.8775559177263, 951.3150531617224, 14697.779533307223, 14867.479638212611, 14928.253587320374, 14972.0, 14991.550253492413, 32594.348113038082, 32830.83584582157, 33143.66856331406, 33897.15257118592, 34594.48108278428, 47178.76410618062, 47266.291005635634, 47436.7628161857, 47586.52413475821, 47642.0, 7392.482526223328, 7491.475596708178, 7499.925000749922, 7647.120581133241, 7692.307692307719, 11256.0, 11372.658820235407, 11803.940980295043, 12037.879621203676, 12260.877391225973, 8949.821003580022, 10335.896641033494, 10411.167106631603, 10602.151827853908, 10704.983026612459, 9879.012098790063, 10027.749306267402, 10100.54547545377, 10156.949215253877, 10419.166466682798, 6441.0, 7229.674664639999, 10091.293609447563, 10544.683659490227, 10753.623623173151, 7236.6019868907715, 7390.815229619303, 7427.554346739213, 7440.0, 7692.0, 9420.0, 10073.395596264247, 10120.190384769348, 10186.0, 10186.847197292194], "value": 8042.121317604108, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.0231828446947, 1423.9288035598217, 1467.4863797670816, 1763.4974032400753, 1804.630050839578, 6817.590944543331, 7672.6930922763095, 7693.153753087156, 7951.125376208613, 7973.880391794128, 7677.270659287359, 7719.150893401721, 7720.189380115091, 7720.189380115091, 7721.498102623325, 2187.84685072045, 2208.3706143749037, 2209.359285807114, 2210.45843768277, 2222.3666255117296, 2156.9892150539226, 2173.6304828179245, 2177.3903307073965, 2177.738671359439, 2191.9890400547974, 2175.1408193763455, 2198.362474882282, 2198.5712786006734, 2201.317591546626, 2227.8106360959255, 2121.596896589651, 2128.787121287882, 2136.722226110596, 2138.8395870309787, 2145.5088713344153, 2122.8089471947446, 2153.9784602153936, 2158.3956492182215, 2160.7731188225166, 2162.1459523488293, 7838.412119091091, 7975.601219939038, 7978.361731061501, 7987.241212084843, 7987.880181797278, 4535.705179163377, 4706.635075828006, 4719.669623126382, 4734.242521196592, 4765.070811191819, 2848.5299925512268, 2857.7856660750317, 2884.884604615813, 2891.0, 2956.8965086222092, 921.0835218957113, 922.6355589542161, 944.7685317097355, 950.2540505703059, 975.4683697384942, 10898.782024359547, 10898.945505272502, 10956.616518421817, 11000.614978475794, 11026.44867756617, 4148.128892932518, 4169.874903752892, 4331.696781225284, 4356.085222103394, 4381.5618438155925, 9263.934647515622, 9285.953570232106, 9297.628094876265, 9389.295802814817, 9395.154436100784, 4667.766611669471, 4701.529847015271, 4704.529547045268, 4704.882377940579, 4705.270683044134, 3635.363811333059, 4147.834086636501, 4258.382534532476, 4278.379634952977, 4279.293916503742, 3752.1745216052423, 3835.5013848199555, 3896.2207558488417, 3920.862769803043, 3945.0531872351003, 1270.9300988445725, 1287.0861688201294, 1293.95471158509, 1303.4916382610788, 1303.6154334471353, 1121.8429419881222, 1122.1471681522103, 1200.6938230751102, 1226.7669142862828, 1259.993700031494, 7388.630568471555, 7413.740519081806, 7544.585047822313, 7553.848923021509, 7771.611419429119, 1077.0145317034983, 1077.8437126616755, 1081.691717860406, 1102.4322473925934, 1113.4210210690396, 5551.750171242304, 5715.5427565794635, 5723.627964182315, 5749.453801888814, 5749.88500229993, 9489.478078705737, 9631.71104866855, 10004.149647280063, 10023.69928902134, 10077.647282345082, 9859.852102218472, 9872.0, 9877.7036688898, 9908.20734341251, 9930.80138397228, 7451.403887688972, 7526.774196774106, 7588.544687318778, 7615.5430674159725, 7635.198304178092, 7204.4956853019785, 7215.8556828864175, 7225.421966242583, 7255.673494692646, 7309.926900731138, 9031.187193152386, 9110.407823491718, 9152.359334846496, 9269.490178040003, 9359.812803743751, 8963.282937365126, 9231.676891308773, 9367.250619950524, 9412.435253884514, 9500.85748713756, 5778.8266352009505, 6436.967815160894, 6463.15978922737, 7224.313690199423, 7538.736144234926, 7492.700291988477, 7513.436492262993, 7553.131389890233, 7566.31903128721, 7594.278543538355, 6663.733450661919, 6811.046453496416, 6856.485763567653, 6898.965505172643, 6997.05539752127, 6820.31796820314, 6822.590644561342, 6893.689783959834, 6922.723091076301, 6956.234814170539, 7015.368616824306, 7075.292470752884, 7152.998580198672, 7181.640917954186, 7252.238514956065, 6615.900761488485, 6619.900701489578, 6678.098456708282, 6686.866262674816, 6688.699008544724, 6706.396424321834, 6744.730210791513, 6763.898541521783, 6807.115075040213, 6818.624975626388], "value": 4515.005417882587, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.3212739209387, 303.9878404863807, 307.1430708323777, 314.2222998079752, 319.63082639551317, 5262.289590905227, 5268.578513718903, 5274.966894035931, 5318.228856815759, 5323.201519772036, 5242.737863106839, 5252.290940723001, 5253.423972808152, 5270.92093618596, 5275.8872265363425, 3888.786116763577, 4021.959780402188, 4127.731697439672, 4146.3780432935155, 4146.917061658765, 4107.527634322047, 4112.547619761824, 4142.917141657165, 4148.668106551484, 4154.813033413504, 4070.4911886014247, 4095.9385609215888, 4097.405876147956, 4105.3431450967855, 4116.300228961084, 3995.6403923646867, 4001.9399709004388, 4073.8574149904757, 4098.8360465581345, 4100.91798164035, 3592.604813470516, 3616.8191590420374, 3622.655847694491, 3626.4741612466046, 3631.5823680276576, 4994.850154495371, 5016.44819069902, 5041.344625198701, 5049.949500504985, 5058.0, 4642.698224615389, 4726.787294571753, 4734.952650473486, 4760.428748550162, 4779.641526885497, 5544.500994910478, 5551.333839939192, 5558.6942718150485, 5576.776928922838, 5595.461248156748, 3968.3452230381954, 3969.920601587981, 3973.940390894139, 3974.741641793274, 3985.242803867256, 5564.1931919871795, 5768.192453056576, 5854.531637469035, 5866.032104702719, 5895.115732640095, 4028.254772867029, 4029.2344454554127, 4036.9596304036586, 4061.329880569732, 4064.248114098901, 4113.4446849675505, 4114.7119701621195, 4121.1345617420075, 4135.648469880094, 4142.378643203544, 4651.695920421842, 4695.647826413033, 4697.976510117496, 4714.713364018448, 4717.811287548459, 5498.532624726863, 5589.74846131925, 5616.326040875121, 5625.240592520039, 5633.8309850704545, 1438.3099857667198, 1453.7383271011108, 1457.2203870929002, 1459.8175228096488, 1461.335092532895, 915.5834095486538, 946.5125460387768, 975.8145952269047, 982.759223990127, 993.9304248702666, 4816.831410900601, 4822.324874517571, 4828.0, 4851.636127290467, 4853.805847766121, 5658.236138121383, 5669.461401166883, 5674.97162514193, 5679.756496183984, 5686.630369026, 4663.930041049387, 4817.229243321051, 4820.39745031871, 4839.854804355875, 4979.601631869442, 3090.5518699788404, 3101.5967924169713, 3105.503119500869, 3108.4870996285813, 3121.71904528589, 5489.258950041693, 5492.395836457987, 5493.862653433696, 5511.696856672841, 5517.282753242133, 5852.970735146382, 5914.2311499504785, 5937.52499800015, 5962.731677074542, 5985.40145985398, 5463.31708536433, 5468.589855760754, 5472.699001554873, 5488.91766623501, 5489.917651235155, 5588.636738611977, 5701.686407247641, 5728.828135155952, 5751.3673495916255, 5756.539476841926, 5635.6618602883955, 5646.717664116695, 5649.774009039593, 5666.490015898589, 5673.631213971079, 5479.369872464717, 5482.890342193214, 5509.090999984957, 5512.448755124456, 5526.751296191601, 3726.2920045191327, 3961.2077584483795, 3964.6828253739054, 4020.195960807792, 4052.5542190359624, 5683.318001839806, 5703.230063941315, 5721.799737009184, 5741.569382296261, 5743.42565743439, 5541.473560011793, 5547.44525547442, 5566.081596536688, 5583.218349431002, 5588.580856435865, 5412.024611017029, 5505.284313039279, 5546.833594992157, 5561.193626923992, 5562.944370556243, 5214.51386354887, 5443.891122177613, 5477.4796394342475, 5483.369412517452, 5494.450554944474, 5432.538234250133, 5562.471565201299, 5570.805021824217, 5583.74873130702, 5589.077802162597, 5408.026555220098, 5416.4041955385665, 5440.646357986719, 5458.61789674719, 5459.617826752089], "value": 4185.023095776254, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.1994885421453, 763.4655740981314, 773.2036002916994, 774.1987043410069, 775.6315750018746, 12141.878581214185, 12379.56671516497, 13511.527096551623, 14056.508022219225, 14097.647558811035, 14155.079919805205, 14211.71576568468, 14236.928815355908, 14250.4299828007, 14263.643408914782, 656.0913135307586, 815.9836803263946, 829.0217543298905, 829.4069740135802, 829.4732844643635, 798.5687728626534, 814.9266566009057, 820.5938060659981, 821.289584509401, 824.4640983360804, 848.9915100848974, 851.1403482482706, 854.4574195385912, 855.8459477294084, 858.635080090962, 843.7173546861809, 847.6058632735777, 851.6678495386835, 851.812601227732, 852.7058164933088, 619.1023016625866, 620.4292051312804, 622.7197761007565, 623.1711823275033, 624.5128799536369, 13097.0, 13111.082224244306, 13216.140950838164, 13240.801387979189, 13242.73514529704, 12321.075919305998, 12364.319962402154, 12398.0, 12585.433655485525, 12597.307148106851, 9639.373440726331, 9878.802423951482, 9960.402375857471, 9967.152792012688, 9995.850062249072, 3275.918102047468, 3319.7257183922407, 3321.0534997525588, 3345.280764635615, 3359.2945481448924, 46666.30000549994, 47019.764901175615, 47558.762206189094, 47800.0, 47812.0, 9350.111739384747, 9368.718938431857, 9515.952420237993, 9706.417614943126, 10179.0, 17012.0, 17108.657826843395, 17126.0, 17144.914275428542, 17192.398266060878, 6979.162500499972, 7042.683079261343, 7086.858262834715, 7104.606916833088, 7131.037309963089, 3864.0533069397616, 3887.7861717605238, 3910.7458015228917, 3962.0491082140657, 4005.459262999516, 3025.7579393648457, 3170.9207269817975, 3173.381190667844, 3206.5350524173864, 3209.5988001499813, 541.5829811045473, 564.8531381840751, 566.2101368590793, 576.7462316580775, 577.2149876168407, 627.2942939193407, 629.6757170057424, 631.766246488793, 637.073058699591, 655.0926966151914, 7811.726589569338, 8059.5164290142775, 8152.592370381457, 8195.0, 8352.874706879402, 631.7378288010516, 637.3721883944311, 648.7469886744079, 660.5442244851038, 672.0557616548757, 3847.9230415391535, 3898.083950271684, 3921.6078392160557, 3931.724779265481, 4027.1140349123148, 52090.21864672033, 53547.0, 54241.0, 54279.72860135674, 54470.45529544654, 46817.531824681995, 46843.76578117088, 47067.76466117716, 47070.76464617655, 47328.0, 42359.57640423618, 43407.56592434035, 43860.0, 44141.0, 44309.77845110754, 7603.505772124794, 7778.261065198797, 7833.216678332121, 7876.960615196887, 7941.364690824836, 30031.849840750656, 30171.245718857204, 30252.84873575618, 30299.697003029687, 30874.845625772625, 35156.296874062886, 36927.0, 39048.41427378648, 40179.0, 40667.3899891496, 9599.664011759834, 9834.508274586098, 9843.360181588174, 9970.451625160396, 10230.335028223142, 10944.835827462754, 11177.88822111801, 11234.3259404436, 11277.154213433862, 11446.885531144582, 11147.386893720923, 11336.716582085513, 11339.773204535699, 11341.886581134413, 11800.17398782077, 11000.0, 11026.228164028762, 11213.327200368005, 11363.715907102389, 11578.184273769306, 10592.417417042137, 10799.352038877692, 11132.944335278271, 11487.023602993839, 11496.597619083292, 9450.209539014333, 9775.853362199716, 9777.560009799718, 9914.0, 9994.950025249827, 9364.0, 9375.624975000923, 10190.184785217312, 10222.744431388977, 10241.07830295277], "value": 6092.252418859732, "unit": "score"}], "name": "dromaeo_css", "value": 6381.3370788673565, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 114.0, 115.0, 115.0, 126.0, 115.0, 114.0, 113.0, 114.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 140.0, 162.0, 196.0, 136.0, 160.0, 161.0, 141.0, 180.0, 141.0], "value": 158.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 160.0, 161.0, 163.0, 176.0, 164.0, 162.0, 165.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 73.0, 72.0, 73.0, 75.0, 144.0, 77.0, 78.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 132.0, 96.0, 94.0, 96.0, 140.0, 92.0, 94.0, 136.0], "value": 106.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 146.0, 146.0, 146.0, 147.0, 149.0, 146.0, 150.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 66.0, 67.0, 69.0, 66.0, 66.0, 66.0, 70.0, 64.0], "value": 67.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 64.0, 65.0, 64.0, 65.0, 64.0, 63.0, 65.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 94.0, 86.0, 86.0, 85.0, 85.0, 85.0, 93.0, 86.0, 86.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 144.0, 146.0, 143.0, 153.0, 142.0, 141.0, 151.0, 138.0], "value": 143.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 170.0, 171.0, 172.0, 174.0, 178.0, 171.0, 172.0, 174.0, 171.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 72.0, 71.0, 71.0, 72.0, 71.0, 70.0, 83.0], "value": 73.0, "unit": "score"}], "name": "kraken", "value": 1594.3, "alertThreshold": 2.0}]} 04:37:05 INFO - Return code: 0 04:37:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:37:05 ERROR - # TBPL SUCCESS # 04:37:05 INFO - Running post-action listener: _resource_record_post_action 04:37:05 INFO - Running post-run listener: _resource_record_post_run 04:37:06 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520429568; Read time: 8; Write time: 515884 04:37:06 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 172814336; Read time: 0; Write time: 275984 04:37:06 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286990336; Read time: 8; Write time: 193136 04:37:06 INFO - Running post-run listener: _upload_blobber_files 04:37:06 INFO - Blob upload gear active. 04:37:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:37:06 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:37:06 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:37:06 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:37:07 INFO - (blobuploader) - INFO - Open directory for files ... 04:37:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:37:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:37:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:08 INFO - (blobuploader) - INFO - Done attempting. 04:37:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:37:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:37:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:09 INFO - (blobuploader) - INFO - Done attempting. 04:37:09 INFO - (blobuploader) - INFO - Iteration through files over. 04:37:09 INFO - Return code: 0 04:37:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:37:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:37:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7be9e4cfd14e211b1e5e682a2718aff6740f7e7179069eb5bb30201edd11218e3093d9ab1a7ea8efe5b0b7abbdf00c032474a6469582a28bed15bb221e6d7809", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df85e094c3c0815ffa1eaebfe9d33b768bff5f1415c2d8c506723e891b5f21ac09524a25a4975a28c051ceb70b43247a2fe228c8b5340b53c179ecaa4f5d446d"} 04:37:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:37:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:37:09 INFO - Contents: 04:37:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7be9e4cfd14e211b1e5e682a2718aff6740f7e7179069eb5bb30201edd11218e3093d9ab1a7ea8efe5b0b7abbdf00c032474a6469582a28bed15bb221e6d7809", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df85e094c3c0815ffa1eaebfe9d33b768bff5f1415c2d8c506723e891b5f21ac09524a25a4975a28c051ceb70b43247a2fe228c8b5340b53c179ecaa4f5d446d"} 04:37:09 INFO - Running post-run listener: copy_logs_to_upload_dir 04:37:09 INFO - Copying logs to upload dir... 04:37:09 INFO - mkdir: /builds/slave/test/build/upload/logs 04:37:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.614468 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-08 04:37:08.635236) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 04:37:08.638654) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7be9e4cfd14e211b1e5e682a2718aff6740f7e7179069eb5bb30201edd11218e3093d9ab1a7ea8efe5b0b7abbdf00c032474a6469582a28bed15bb221e6d7809", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df85e094c3c0815ffa1eaebfe9d33b768bff5f1415c2d8c506723e891b5f21ac09524a25a4975a28c051ceb70b43247a2fe228c8b5340b53c179ecaa4f5d446d"} build_url:https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011519 build_url: 'https://queue.taskcluster.net/v1/task/NMw7y7z3Q96MtzWtOr8qPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7be9e4cfd14e211b1e5e682a2718aff6740f7e7179069eb5bb30201edd11218e3093d9ab1a7ea8efe5b0b7abbdf00c032474a6469582a28bed15bb221e6d7809", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df85e094c3c0815ffa1eaebfe9d33b768bff5f1415c2d8c506723e891b5f21ac09524a25a4975a28c051ceb70b43247a2fe228c8b5340b53c179ecaa4f5d446d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 04:37:08.663491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:37:08.663816) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460113408.518970-1061624879 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 04:37:08.748138) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 04:37:08.748494) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 04:37:08.748780) ========= ========= Total master_lag: 0.31 =========