builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1456247821.71 results: success (0) buildid: 20160223075310 builduid: 0dca9a6a2fc74004b752fa74d8f20555 revision: 25697d5038158fadb93ec3ed76f3c2e84fd4f60f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:01.709206) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:01.709709) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:01.710042) ========= 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=652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006697 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:01.731823) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:01.732120) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:01.744979) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:01.745288) ========= 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=652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:01.794245) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:01.794536) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:01.794905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:01.795197) ========= 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=652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-23 09:17:01-- 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% 220M=0s 2016-02-23 09:17:02 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177689 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:01.985015) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:01.985324) ========= 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=652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022379 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:02.036524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:02.037116) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 25697d5038158fadb93ec3ed76f3c2e84fd4f60f --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 25697d5038158fadb93ec3ed76f3c2e84fd4f60f --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=652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-23 09:17:02,299 truncating revision to first 12 chars 2016-02-23 09:17:02,300 Setting DEBUG logging. 2016-02-23 09:17:02,300 attempt 1/10 2016-02-23 09:17:02,300 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/25697d503815?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-23 09:17:02,548 unpacking tar archive at: mozilla-central-25697d503815/testing/mozharness/ program finished with exit code 0 elapsedTime=0.572356 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:02.650669) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:02.651029) ========= echo 25697d5038158fadb93ec3ed76f3c2e84fd4f60f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'25697d5038158fadb93ec3ed76f3c2e84fd4f60f'] 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=652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 25697d5038158fadb93ec3ed76f3c2e84fd4f60f program finished with exit code 0 elapsedTime=0.004585 script_repo_revision: '25697d5038158fadb93ec3ed76f3c2e84fd4f60f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:02.701438) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:02.701793) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 09:17:02.711358) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-02-23 09:17:02.711670) ========= /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=652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:17:03 INFO - MultiFileLogger online at 20160223 09:17:03 in /builds/slave/test 09:17:03 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 09:17:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:17:03 INFO - {'append_to_log': False, 09:17:03 INFO - 'base_work_dir': '/builds/slave/test', 09:17:03 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:17:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:17:03 INFO - 'branch': 'Firefox-Non-PGO', 09:17:03 INFO - 'buildbot_json_path': 'buildprops.json', 09:17:03 INFO - 'config_files': ('talos/linux_config.py',), 09:17:03 INFO - 'default_actions': ('clobber', 09:17:03 INFO - 'read-buildbot-config', 09:17:03 INFO - 'download-and-extract', 09:17:03 INFO - 'populate-webroot', 09:17:03 INFO - 'create-virtualenv', 09:17:03 INFO - 'install', 09:17:03 INFO - 'run-tests'), 09:17:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:17:03 INFO - 'download_minidump_stackwalk': True, 09:17:03 INFO - 'download_symbols': 'ondemand', 09:17:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:17:03 INFO - 'tooltool.py': '/tools/tooltool.py', 09:17:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:17:03 INFO - '/tools/misc-python/virtualenv.py')}, 09:17:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:17:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:17:03 INFO - 'installer_path': 'installer.exe', 09:17:03 INFO - 'log_level': 'info', 09:17:03 INFO - 'log_name': 'talos', 09:17:03 INFO - 'log_to_console': True, 09:17:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:17:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:17:03 INFO - 'opt_config_files': (), 09:17:03 INFO - 'pip_index': False, 09:17:03 INFO - 'sps_profile': False, 09:17:03 INFO - 'sps_profile_interval': 0, 09:17:03 INFO - 'suite': 'dromaeojs-e10s', 09:17:03 INFO - 'system_bits': '32', 09:17:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:17:03 INFO - 'title': 'talos-linux64-ix-046', 09:17:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:17:03 INFO - 'use_talos_json': True, 09:17:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:17:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:17:03 INFO - 'work_dir': 'build'} 09:17:03 INFO - ##### 09:17:03 INFO - ##### Running clobber step. 09:17:03 INFO - ##### 09:17:03 INFO - Running pre-action listener: _resource_record_pre_action 09:17:03 INFO - Running main action method: clobber 09:17:03 INFO - rmtree: /builds/slave/test/build 09:17:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:17:03 INFO - Running post-action listener: _resource_record_post_action 09:17:03 INFO - ##### 09:17:03 INFO - ##### Running read-buildbot-config step. 09:17:03 INFO - ##### 09:17:03 INFO - Running pre-action listener: _resource_record_pre_action 09:17:03 INFO - Running main action method: read_buildbot_config 09:17:03 INFO - Using buildbot properties: 09:17:03 INFO - { 09:17:03 INFO - "project": "", 09:17:03 INFO - "product": "firefox", 09:17:03 INFO - "script_repo_revision": "production", 09:17:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:17:03 INFO - "repository": "", 09:17:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:17:03 INFO - "buildid": "20160223075310", 09:17:03 INFO - "pgo_build": "False", 09:17:03 INFO - "basedir": "/builds/slave/test", 09:17:03 INFO - "buildnumber": 206, 09:17:03 INFO - "slavename": "talos-linux64-ix-046", 09:17:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:17:03 INFO - "platform": "ubuntu64_hw", 09:17:03 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:17:03 INFO - "branch": "mozilla-central", 09:17:03 INFO - "repo_path": "mozilla-central", 09:17:03 INFO - "revision": "25697d5038158fadb93ec3ed76f3c2e84fd4f60f", 09:17:03 INFO - "stage_platform": "linux64", 09:17:03 INFO - "builduid": "0dca9a6a2fc74004b752fa74d8f20555", 09:17:03 INFO - "slavebuilddir": "test" 09:17:03 INFO - } 09:17:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 09:17:03 INFO - Running post-action listener: _resource_record_post_action 09:17:03 INFO - ##### 09:17:03 INFO - ##### Running download-and-extract step. 09:17:03 INFO - ##### 09:17:03 INFO - Running pre-action listener: _resource_record_pre_action 09:17:03 INFO - Running main action method: download_and_extract 09:17:03 INFO - mkdir: /builds/slave/test/build/tests 09:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:03 INFO - https://queue.taskcluster.net/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:17:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/test_packages.json 09:17:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/test_packages.json 09:17:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:17:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:17:04 INFO - Downloaded 1448 bytes. 09:17:04 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:17:04 INFO - Using the following test package requirements: 09:17:04 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:17:04 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:17:04 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:17:04 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:04 INFO - u'jsshell-linux-x86_64.zip'], 09:17:04 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:17:04 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:17:04 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:17:04 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:17:04 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:17:04 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:17:04 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:17:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:17:04 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09: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')]} 09:17:04 INFO - https://queue.taskcluster.net/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:17:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:17:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:17:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:17:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:17:05 INFO - Downloaded 22051564 bytes. 09:17:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:17:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:17:07 INFO - Return code: 0 09:17:07 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09: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')]} 09:17:07 INFO - https://queue.taskcluster.net/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:17:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:17:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:17:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:17:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:17:08 INFO - Downloaded 22051564 bytes. 09:17:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:17:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:17:09 INFO - Return code: 0 09:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:09 INFO - https://queue.taskcluster.net/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:17:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:17:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:17:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:17:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:17:10 INFO - Downloaded 10707015 bytes. 09:17:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:17:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:17:11 INFO - Return code: 0 09:17:11 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')]} 09:17:11 INFO - https://queue.taskcluster.net/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:17:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:17:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:17:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:17:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:17:12 INFO - Downloaded 54835014 bytes. 09:17:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:17:12 INFO - mkdir: /builds/slave/test/properties 09:17:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:17:12 INFO - Writing to file /builds/slave/test/properties/build_url 09:17:12 INFO - Contents: 09:17:12 INFO - build_url:https://queue.taskcluster.net/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:17:13 INFO - Running post-action listener: _resource_record_post_action 09:17:13 INFO - Running post-action listener: set_extra_try_arguments 09:17:13 INFO - ##### 09:17:13 INFO - ##### Running populate-webroot step. 09:17:13 INFO - ##### 09:17:13 INFO - Running pre-action listener: _resource_record_pre_action 09:17:13 INFO - Running main action method: populate_webroot 09:17:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:17:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:17:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:17:13 INFO - '--tppagecycles', 09:17:13 INFO - '7'], 09:17:13 INFO - 'tests': ['tsvgm']}}, 09:17:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:17:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:17:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:17:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:17:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:17:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:17:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:13 INFO - 'talos_options': ['--e10s'], 09:17:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:13 INFO - 'tests': ['damp', 'tps']}, 09:17:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:13 INFO - 'talos_options': ['--e10s'], 09:17:13 INFO - 'tests': ['damp', 'tps']}, 09:17:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:17:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:17:13 INFO - 'other': {'tests': ['a11yr', 09:17:13 INFO - 'ts_paint', 09:17:13 INFO - 'tpaint', 09:17:13 INFO - 'sessionrestore', 09:17:13 INFO - 'sessionrestore_no_auto_restore']}, 09:17:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:17:13 INFO - 'tests': ['a11yr', 09:17:13 INFO - 'ts_paint', 09:17:13 INFO - 'tpaint', 09:17:13 INFO - 'sessionrestore', 09:17:13 INFO - 'sessionrestore_no_auto_restore']}, 09:17:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:17:13 INFO - 'tests': ['a11yr', 09:17:13 INFO - 'ts_paint', 09:17:13 INFO - 'tpaint', 09:17:13 INFO - 'sessionrestore', 09:17:13 INFO - 'sessionrestore_no_auto_restore']}, 09:17:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:17:13 INFO - 'tests': ['a11yr', 09:17:13 INFO - 'ts_paint', 09:17:13 INFO - 'tpaint', 09:17:13 INFO - 'sessionrestore', 09:17:13 INFO - 'sessionrestore_no_auto_restore']}, 09:17:13 INFO - 'other_l64': {'tests': ['a11yr', 09:17:13 INFO - 'ts_paint', 09:17:13 INFO - 'tpaint', 09:17:13 INFO - 'sessionrestore', 09:17:13 INFO - 'sessionrestore_no_auto_restore']}, 09:17:13 INFO - 'other_nol64': {'tests': ['a11yr', 09:17:13 INFO - 'ts_paint', 09:17:13 INFO - 'tpaint', 09:17:13 INFO - 'sessionrestore', 09:17:13 INFO - 'sessionrestore_no_auto_restore']}, 09:17:13 INFO - 'svgr': {'tests': ['tsvgx', 09:17:13 INFO - 'tsvgr_opacity', 09:17:13 INFO - 'tart', 09:17:13 INFO - 'tscrollx', 09:17:13 INFO - 'cart']}, 09:17:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:17:13 INFO - 'tests': ['tsvgx', 09:17:13 INFO - 'tsvgr_opacity', 09:17:13 INFO - 'tart', 09:17:13 INFO - 'tscrollx', 09:17:13 INFO - 'cart']}, 09:17:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:13 INFO - 'tests': ['tp5o']}, 09:17:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:13 INFO - 'talos_options': ['--e10s'], 09:17:13 INFO - 'tests': ['tp5o']}, 09:17:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:13 INFO - 'talos_options': ['--xperf_path', 09:17:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:13 INFO - 'tests': ['tp5n']}, 09:17:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:13 INFO - 'talos_options': ['--e10s', 09:17:13 INFO - '--xperf_path', 09:17:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:13 INFO - 'tests': ['tp5n']}}, 09:17:13 INFO - 'talos.zip': {'path': '', 09:17:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:17:13 INFO - Running post-action listener: _resource_record_post_action 09:17:13 INFO - ##### 09:17:13 INFO - ##### Running create-virtualenv step. 09:17:13 INFO - ##### 09:17:13 INFO - Running pre-action listener: _resource_record_pre_action 09:17:13 INFO - Running main action method: create_virtualenv 09:17:13 INFO - Creating virtualenv /builds/slave/test/build/venv 09:17:13 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 09:17:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:17:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:17:13 INFO - Using real prefix '/usr' 09:17:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:17:13 INFO - Installing distribute.............................................................................................................................................................................................done. 09:17:15 INFO - Installing pip.................done. 09:17:15 INFO - Return code: 0 09:17:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:15 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 0x7f0a6b903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a53b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2434100>, '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 0x2435000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435490>, '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': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', '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 09:17:15 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 09:17:15 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 09:17:15 INFO - Using env: {'DISPLAY': ':0', 09:17:15 INFO - 'HOME': '/home/cltbld', 09:17:15 INFO - 'LANG': 'en_US.UTF-8', 09:17:15 INFO - 'LANGUAGE': 'en_US:en', 09:17:15 INFO - 'LOGNAME': 'cltbld', 09:17:15 INFO - 'MAIL': '/var/mail/cltbld', 09:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:15 INFO - 'MOZ_NO_REMOTE': '1', 09:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:15 INFO - 'NO_EM_RESTART': '1', 09:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:15 INFO - 'PWD': '/builds/slave/test', 09:17:15 INFO - 'SHELL': '/bin/bash', 09:17:15 INFO - 'SHLVL': '1', 09:17:15 INFO - 'TERM': 'linux', 09:17:15 INFO - 'TMOUT': '86400', 09:17:15 INFO - 'USER': 'cltbld', 09:17:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', 09:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:15 INFO - '_': '/tools/buildbot/bin/python'} 09:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:15 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 09:17:15 INFO - Cleaning up... 09:17:15 INFO - Return code: 0 09:17:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:15 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 0x7f0a6b903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a53b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2434100>, '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 0x2435000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435490>, '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': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', '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 09:17:15 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 09:17:15 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 09:17:15 INFO - Using env: {'DISPLAY': ':0', 09:17:15 INFO - 'HOME': '/home/cltbld', 09:17:15 INFO - 'LANG': 'en_US.UTF-8', 09:17:15 INFO - 'LANGUAGE': 'en_US:en', 09:17:15 INFO - 'LOGNAME': 'cltbld', 09:17:15 INFO - 'MAIL': '/var/mail/cltbld', 09:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:15 INFO - 'MOZ_NO_REMOTE': '1', 09:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:15 INFO - 'NO_EM_RESTART': '1', 09:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:15 INFO - 'PWD': '/builds/slave/test', 09:17:15 INFO - 'SHELL': '/bin/bash', 09:17:15 INFO - 'SHLVL': '1', 09:17:15 INFO - 'TERM': 'linux', 09:17:15 INFO - 'TMOUT': '86400', 09:17:15 INFO - 'USER': 'cltbld', 09:17:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', 09:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:15 INFO - '_': '/tools/buildbot/bin/python'} 09:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:16 INFO - Downloading/unpacking psutil>=0.7.1 09:17:16 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 09:17:16 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 09:17:16 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 09:17:16 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 09:17:16 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 09:17:16 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 09:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:17:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:18 INFO - Installing collected packages: psutil 09:17:18 INFO - Running setup.py install for psutil 09:17:18 INFO - building 'psutil._psutil_linux' extension 09:17:18 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 09:17:18 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 09:17:18 INFO - building 'psutil._psutil_posix' extension 09:17:18 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 09:17:18 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 09:17:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:18 INFO - Successfully installed psutil 09:17:18 INFO - Cleaning up... 09:17:18 INFO - Return code: 0 09:17:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:17: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')]} 09:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17: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')]} 09:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:18 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 0x7f0a6b903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a53b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2434100>, '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 0x2435000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435490>, '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': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', '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 09:17:18 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 09:17:18 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 09:17:18 INFO - Using env: {'DISPLAY': ':0', 09:17:18 INFO - 'HOME': '/home/cltbld', 09:17:18 INFO - 'LANG': 'en_US.UTF-8', 09:17:18 INFO - 'LANGUAGE': 'en_US:en', 09:17:18 INFO - 'LOGNAME': 'cltbld', 09:17:18 INFO - 'MAIL': '/var/mail/cltbld', 09:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:18 INFO - 'MOZ_NO_REMOTE': '1', 09:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:18 INFO - 'NO_EM_RESTART': '1', 09:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:18 INFO - 'PWD': '/builds/slave/test', 09:17:18 INFO - 'SHELL': '/bin/bash', 09:17:18 INFO - 'SHLVL': '1', 09:17:18 INFO - 'TERM': 'linux', 09:17:18 INFO - 'TMOUT': '86400', 09:17:18 INFO - 'USER': 'cltbld', 09:17:18 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', 09:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:18 INFO - '_': '/tools/buildbot/bin/python'} 09:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:17:18 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 09:17:18 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 09:17:18 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 09:17:18 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 09:17:18 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 09:17:18 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 09:17:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:17:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:17:20 INFO - Installing collected packages: mozsystemmonitor 09:17:20 INFO - Running setup.py install for mozsystemmonitor 09:17:20 INFO - Successfully installed mozsystemmonitor 09:17:20 INFO - Cleaning up... 09:17:20 INFO - Return code: 0 09:17:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:17:20 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')]} 09:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:20 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')]} 09:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:20 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 0x7f0a6b903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a53b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2434100>, '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 0x2435000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435490>, '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': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', '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 09:17:20 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 09:17:20 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 09:17:20 INFO - Using env: {'DISPLAY': ':0', 09:17:20 INFO - 'HOME': '/home/cltbld', 09:17:20 INFO - 'LANG': 'en_US.UTF-8', 09:17:20 INFO - 'LANGUAGE': 'en_US:en', 09:17:20 INFO - 'LOGNAME': 'cltbld', 09:17:20 INFO - 'MAIL': '/var/mail/cltbld', 09:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:20 INFO - 'MOZ_NO_REMOTE': '1', 09:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:20 INFO - 'NO_EM_RESTART': '1', 09:17:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:20 INFO - 'PWD': '/builds/slave/test', 09:17:20 INFO - 'SHELL': '/bin/bash', 09:17:20 INFO - 'SHLVL': '1', 09:17:20 INFO - 'TERM': 'linux', 09:17:20 INFO - 'TMOUT': '86400', 09:17:20 INFO - 'USER': 'cltbld', 09:17:20 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', 09:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:20 INFO - '_': '/tools/buildbot/bin/python'} 09:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:20 INFO - Downloading/unpacking blobuploader==1.2.4 09:17:20 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 09:17:20 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 09:17:20 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 09:17:20 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 09:17:20 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 09:17:20 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 09:17:22 INFO - Downloading blobuploader-1.2.4.tar.gz 09:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:17:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:17:22 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 09:17:22 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 09:17:22 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 09:17:22 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 09:17:22 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 09:17:22 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 09:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:17:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:17:23 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 09:17:23 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 09:17:23 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 09:17:23 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 09:17:23 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 09:17:23 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 09:17:23 INFO - Downloading docopt-0.6.1.tar.gz 09:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:17:23 INFO - Installing collected packages: blobuploader, requests, docopt 09:17:23 INFO - Running setup.py install for blobuploader 09:17:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:17:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:17:23 INFO - Running setup.py install for requests 09:17:23 INFO - Running setup.py install for docopt 09:17:24 INFO - Successfully installed blobuploader requests docopt 09:17:24 INFO - Cleaning up... 09:17:24 INFO - Return code: 0 09:17:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:24 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 0x7f0a6b903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a53b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2434100>, '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 0x2435000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435490>, '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': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', '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 09:17:24 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 09:17:24 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 09:17:24 INFO - Using env: {'DISPLAY': ':0', 09:17:24 INFO - 'HOME': '/home/cltbld', 09:17:24 INFO - 'LANG': 'en_US.UTF-8', 09:17:24 INFO - 'LANGUAGE': 'en_US:en', 09:17:24 INFO - 'LOGNAME': 'cltbld', 09:17:24 INFO - 'MAIL': '/var/mail/cltbld', 09:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:24 INFO - 'MOZ_NO_REMOTE': '1', 09:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:24 INFO - 'NO_EM_RESTART': '1', 09:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:24 INFO - 'PWD': '/builds/slave/test', 09:17:24 INFO - 'SHELL': '/bin/bash', 09:17:24 INFO - 'SHLVL': '1', 09:17:24 INFO - 'TERM': 'linux', 09:17:24 INFO - 'TMOUT': '86400', 09:17:24 INFO - 'USER': 'cltbld', 09:17:24 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', 09:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:24 INFO - '_': '/tools/buildbot/bin/python'} 09:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:17:24 INFO - Running setup.py (path:/tmp/pip-8HT1OF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:17:24 INFO - Running setup.py (path:/tmp/pip-U3AsbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:17:24 INFO - Running setup.py (path:/tmp/pip-Ushopi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:17:24 INFO - Running setup.py (path:/tmp/pip-qcTeon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:17:24 INFO - Running setup.py (path:/tmp/pip-6GLmWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:17:24 INFO - Running setup.py (path:/tmp/pip-s_yJHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:17:24 INFO - Running setup.py (path:/tmp/pip-Hq_aPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:17:24 INFO - Running setup.py (path:/tmp/pip-c9e0Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:17:24 INFO - Running setup.py (path:/tmp/pip-S8YjP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:17:24 INFO - Running setup.py (path:/tmp/pip-SzhJ8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:17:25 INFO - Running setup.py (path:/tmp/pip-WG0FDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:17:25 INFO - Running setup.py (path:/tmp/pip-PEVwaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:17:25 INFO - Running setup.py (path:/tmp/pip-E7vk6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:17:25 INFO - Running setup.py (path:/tmp/pip-CK6OLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:25 INFO - Running setup.py (path:/tmp/pip-45So0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:17:25 INFO - Running setup.py (path:/tmp/pip-JqVOsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:17:25 INFO - Running setup.py (path:/tmp/pip-QxvnWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:17:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:17:25 INFO - Running setup.py install for manifestparser 09:17:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:17:25 INFO - Running setup.py install for mozcrash 09:17:25 INFO - Running setup.py install for mozdebug 09:17:25 INFO - Running setup.py install for mozdevice 09:17:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:17:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:17:25 INFO - Running setup.py install for mozfile 09:17:26 INFO - Running setup.py install for mozhttpd 09:17:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:17:26 INFO - Running setup.py install for mozinfo 09:17:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:17:26 INFO - Running setup.py install for mozInstall 09:17:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:17:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:17:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:17:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:17:26 INFO - Running setup.py install for mozleak 09:17:26 INFO - Running setup.py install for mozlog 09:17:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:17:26 INFO - Running setup.py install for moznetwork 09:17:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:17:26 INFO - Running setup.py install for mozprocess 09:17:26 INFO - Running setup.py install for mozprofile 09:17:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:17:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:17:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:17:26 INFO - Running setup.py install for mozrunner 09:17:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:17:27 INFO - Running setup.py install for mozscreenshot 09:17:27 INFO - Running setup.py install for moztest 09:17:27 INFO - Running setup.py install for mozversion 09:17:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:17:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:17:27 INFO - Cleaning up... 09:17:27 INFO - Return code: 0 09:17:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09: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')]} 09:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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')]} 09:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:27 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 0x7f0a6b903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a53b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2434100>, '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 0x2435000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435490>, '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': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', '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 09:17:27 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 09:17:27 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 09:17:27 INFO - Using env: {'DISPLAY': ':0', 09:17:27 INFO - 'HOME': '/home/cltbld', 09:17:27 INFO - 'LANG': 'en_US.UTF-8', 09:17:27 INFO - 'LANGUAGE': 'en_US:en', 09:17:27 INFO - 'LOGNAME': 'cltbld', 09:17:27 INFO - 'MAIL': '/var/mail/cltbld', 09:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:27 INFO - 'MOZ_NO_REMOTE': '1', 09:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:27 INFO - 'NO_EM_RESTART': '1', 09:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:27 INFO - 'PWD': '/builds/slave/test', 09:17:27 INFO - 'SHELL': '/bin/bash', 09:17:27 INFO - 'SHLVL': '1', 09:17:27 INFO - 'TERM': 'linux', 09:17:27 INFO - 'TMOUT': '86400', 09:17:27 INFO - 'USER': 'cltbld', 09:17:27 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', 09:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:27 INFO - '_': '/tools/buildbot/bin/python'} 09:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:17:27 INFO - Running setup.py (path:/tmp/pip-OJgBwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:17:27 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)) 09:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:17:27 INFO - Running setup.py (path:/tmp/pip-wBJHBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 09:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:17:27 INFO - Running setup.py (path:/tmp/pip-jlnoFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:17:27 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)) 09:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:17:27 INFO - Running setup.py (path:/tmp/pip-kTpbri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:17:27 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)) 09:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:17:27 INFO - Running setup.py (path:/tmp/pip-Vw56uJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:17:27 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)) 09:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:17:27 INFO - Running setup.py (path:/tmp/pip-fmiE4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:17:27 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)) 09:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:17:27 INFO - Running setup.py (path:/tmp/pip-lHcsWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:17:28 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)) 09:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:17:28 INFO - Running setup.py (path:/tmp/pip-7HsJy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:17:28 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)) 09:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:17:28 INFO - Running setup.py (path:/tmp/pip-uPFjas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:17:28 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)) 09:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:17:28 INFO - Running setup.py (path:/tmp/pip-X6nXUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:17:28 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)) 09:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:17:28 INFO - Running setup.py (path:/tmp/pip-JrrgQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:17:28 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)) 09:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:17:28 INFO - Running setup.py (path:/tmp/pip-WYy8B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:17:28 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)) 09:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:17:28 INFO - Running setup.py (path:/tmp/pip-GEQ1S9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:17:28 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)) 09:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:17:28 INFO - Running setup.py (path:/tmp/pip-Q9CglT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:17:28 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)) 09:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:28 INFO - Running setup.py (path:/tmp/pip-GOxYNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:28 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)) 09:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:17:28 INFO - Running setup.py (path:/tmp/pip-A8rsFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:17:28 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)) 09:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:17:28 INFO - Running setup.py (path:/tmp/pip-YyOd2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:17:28 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)) 09:17:28 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:17:28 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:17:28 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)) 09:17:28 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)) 09:17:28 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)) 09:17:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:17:28 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 09:17:28 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 09:17:28 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 09:17:28 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 09:17:28 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 09:17:28 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 09:17:30 INFO - Downloading blessings-1.6.tar.gz 09:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:17:30 INFO - Installing collected packages: blessings 09:17:30 INFO - Running setup.py install for blessings 09:17:30 INFO - Successfully installed blessings 09:17:30 INFO - Cleaning up... 09:17:30 INFO - Return code: 0 09:17:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:17:31 INFO - Reading from file tmpfile_stdout 09:17:31 INFO - Current package versions: 09:17:31 INFO - argparse == 1.2.1 09:17:31 INFO - blessings == 1.6 09:17:31 INFO - blobuploader == 1.2.4 09:17:31 INFO - docopt == 0.6.1 09:17:31 INFO - manifestparser == 1.1 09:17:31 INFO - mozInstall == 1.12 09:17:31 INFO - mozcrash == 0.16 09:17:31 INFO - mozdebug == 0.1 09:17:31 INFO - mozdevice == 0.48 09:17:31 INFO - mozfile == 1.2 09:17:31 INFO - mozhttpd == 0.7 09:17:31 INFO - mozinfo == 0.9 09:17:31 INFO - mozleak == 0.1 09:17:31 INFO - mozlog == 3.1 09:17:31 INFO - moznetwork == 0.27 09:17:31 INFO - mozprocess == 0.22 09:17:31 INFO - mozprofile == 0.28 09:17:31 INFO - mozrunner == 6.11 09:17:31 INFO - mozscreenshot == 0.1 09:17:31 INFO - mozsystemmonitor == 0.0 09:17:31 INFO - moztest == 0.7 09:17:31 INFO - mozversion == 1.4 09:17:31 INFO - psutil == 3.1.1 09:17:31 INFO - requests == 1.2.3 09:17:31 INFO - wsgiref == 0.1.2 09:17:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:17: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')]} 09:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17: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')]} 09:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:31 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 0x7f0a6b903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a53b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2434100>, '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 0x2435000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435490>, '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': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', '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 09:17:31 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 09:17:31 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 09:17:31 INFO - Using env: {'DISPLAY': ':0', 09:17:31 INFO - 'HOME': '/home/cltbld', 09:17:31 INFO - 'LANG': 'en_US.UTF-8', 09:17:31 INFO - 'LANGUAGE': 'en_US:en', 09:17:31 INFO - 'LOGNAME': 'cltbld', 09:17:31 INFO - 'MAIL': '/var/mail/cltbld', 09:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:31 INFO - 'MOZ_NO_REMOTE': '1', 09:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:31 INFO - 'NO_EM_RESTART': '1', 09:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:31 INFO - 'PWD': '/builds/slave/test', 09:17:31 INFO - 'SHELL': '/bin/bash', 09:17:31 INFO - 'SHLVL': '1', 09:17:31 INFO - 'TERM': 'linux', 09:17:31 INFO - 'TMOUT': '86400', 09:17:31 INFO - 'USER': 'cltbld', 09:17:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', 09:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:31 INFO - '_': '/tools/buildbot/bin/python'} 09:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:31 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)) 09:17:31 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)) 09:17:31 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)) 09:17:31 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)) 09:17:31 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)) 09:17:31 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)) 09:17:31 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)) 09:17:31 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)) 09:17:31 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)) 09:17:31 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)) 09:17:31 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)) 09:17:31 INFO - Cleaning up... 09:17:31 INFO - Return code: 0 09:17:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:17: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')]} 09:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17: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')]} 09:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:31 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 0x7f0a6b903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a53b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2434100>, '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 0x2435000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435490>, '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': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', '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 09:17:31 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 09:17:31 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 09:17:31 INFO - Using env: {'DISPLAY': ':0', 09:17:31 INFO - 'HOME': '/home/cltbld', 09:17:31 INFO - 'LANG': 'en_US.UTF-8', 09:17:31 INFO - 'LANGUAGE': 'en_US:en', 09:17:31 INFO - 'LOGNAME': 'cltbld', 09:17:31 INFO - 'MAIL': '/var/mail/cltbld', 09:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:31 INFO - 'MOZ_NO_REMOTE': '1', 09:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:31 INFO - 'NO_EM_RESTART': '1', 09:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:31 INFO - 'PWD': '/builds/slave/test', 09:17:31 INFO - 'SHELL': '/bin/bash', 09:17:31 INFO - 'SHLVL': '1', 09:17:31 INFO - 'TERM': 'linux', 09:17:31 INFO - 'TMOUT': '86400', 09:17:31 INFO - 'USER': 'cltbld', 09:17:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', 09:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:31 INFO - '_': '/tools/buildbot/bin/python'} 09:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:31 INFO - Downloading/unpacking jsonschema 09:17:31 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 09:17:31 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 09:17:31 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 09:17:31 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 09:17:31 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 09:17:31 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 09:17:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:17:33 INFO - Downloading/unpacking functools32 (from jsonschema) 09:17:33 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 09:17:33 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 09:17:33 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 09:17:33 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 09:17:33 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 09:17:33 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 09:17:33 INFO - Downloading functools32-3.2.3-2.tar.gz 09:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:17:33 INFO - warning: no files found matching '*.txt' 09:17:33 INFO - no previously-included directories found matching 'build' 09:17:33 INFO - no previously-included directories found matching 'dist' 09:17:33 INFO - no previously-included directories found matching '.git*' 09:17:33 INFO - Installing collected packages: jsonschema, functools32 09:17:33 INFO - Running setup.py install for functools32 09:17:33 INFO - warning: no files found matching '*.txt' 09:17:33 INFO - no previously-included directories found matching 'build' 09:17:33 INFO - no previously-included directories found matching 'dist' 09:17:33 INFO - no previously-included directories found matching '.git*' 09:17:33 INFO - Successfully installed jsonschema functools32 09:17:33 INFO - Cleaning up... 09:17:33 INFO - Return code: 0 09:17:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:17:33 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')]} 09:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:33 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')]} 09:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:33 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 0x7f0a6b903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a53b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2434100>, '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 0x2435000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435490>, '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': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', '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 09:17:33 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 09:17:33 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 09:17:33 INFO - Using env: {'DISPLAY': ':0', 09:17:33 INFO - 'HOME': '/home/cltbld', 09:17:33 INFO - 'LANG': 'en_US.UTF-8', 09:17:33 INFO - 'LANGUAGE': 'en_US:en', 09:17:33 INFO - 'LOGNAME': 'cltbld', 09:17:33 INFO - 'MAIL': '/var/mail/cltbld', 09:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:33 INFO - 'MOZ_NO_REMOTE': '1', 09:17:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:33 INFO - 'NO_EM_RESTART': '1', 09:17:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:33 INFO - 'PWD': '/builds/slave/test', 09:17:33 INFO - 'SHELL': '/bin/bash', 09:17:33 INFO - 'SHLVL': '1', 09:17:33 INFO - 'TERM': 'linux', 09:17:33 INFO - 'TMOUT': '86400', 09:17:33 INFO - 'USER': 'cltbld', 09:17:33 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', 09:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:33 INFO - '_': '/tools/buildbot/bin/python'} 09:17:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:33 INFO - Downloading/unpacking flake8 09:17:33 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 09:17:33 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 09:17:33 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 09:17:33 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 09:17:33 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 09:17:33 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 09:17:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:17:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:17:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:17:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:17:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:17:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:17:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:17:36 INFO - no previously-included directories found matching 'docs/_build' 09:17:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:17:36 INFO - Running setup.py install for pep8 09:17:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:17:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:17:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:17:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:17:36 INFO - no previously-included directories found matching 'docs/_build' 09:17:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:17:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:17:36 INFO - Cleaning up... 09:17:36 INFO - Return code: 0 09:17:36 INFO - Running post-action listener: _resource_record_post_action 09:17:36 INFO - Running post-action listener: _start_resource_monitoring 09:17:36 INFO - Starting resource monitoring. 09:17:36 INFO - ##### 09:17:36 INFO - ##### Running install step. 09:17:36 INFO - ##### 09:17:36 INFO - Running pre-action listener: _resource_record_pre_action 09:17:36 INFO - Running main action method: install 09:17:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:17:36 INFO - Reading from file tmpfile_stdout 09:17:36 INFO - Detecting whether we're running mozinstall >=1.0... 09:17:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:17:37 INFO - Reading from file tmpfile_stdout 09:17:37 INFO - Output received: 09:17:37 INFO - Usage: mozinstall [options] installer 09:17:37 INFO - Options: 09:17:37 INFO - -h, --help show this help message and exit 09:17:37 INFO - -d DEST, --destination=DEST 09:17:37 INFO - Directory to install application into. [default: 09:17:37 INFO - "/builds/slave/test"] 09:17:37 INFO - --app=APP Application being installed. [default: firefox] 09:17:37 INFO - mkdir: /builds/slave/test/build/application 09:17:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:17:52 INFO - Reading from file tmpfile_stdout 09:17:52 INFO - Output received: 09:17:52 INFO - /builds/slave/test/build/application/firefox/firefox 09:17:52 INFO - Running post-action listener: _resource_record_post_action 09:17:52 INFO - ##### 09:17:52 INFO - ##### Running run-tests step. 09:17:52 INFO - ##### 09:17:52 INFO - Running pre-action listener: _resource_record_pre_action 09:17:52 INFO - Running main action method: run_tests 09:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:17:52 INFO - Python 2.7.3 09:17:52 INFO - Return code: 0 09:17:52 INFO - grabbing minidump binary from tooltool 09:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:52 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 0x2434100>, '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 0x2435000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2435490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:17:52 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 09:17:52 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 09:17:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:17:52 INFO - Return code: 0 09:17:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:17:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:17:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:17:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:17:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:17:54 INFO - Return code: 0 09:17:54 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/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 09:17:54 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/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 09:17:54 INFO - Using env: {'DISPLAY': ':0', 09:17:54 INFO - 'HOME': '/home/cltbld', 09:17:54 INFO - 'LANG': 'en_US.UTF-8', 09:17:54 INFO - 'LANGUAGE': 'en_US:en', 09:17:54 INFO - 'LOGNAME': 'cltbld', 09:17:54 INFO - 'MAIL': '/var/mail/cltbld', 09:17:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:17:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:54 INFO - 'MOZ_NO_REMOTE': '1', 09:17:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:54 INFO - 'NO_EM_RESTART': '1', 09:17:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:54 INFO - 'PWD': '/builds/slave/test', 09:17:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:17:54 INFO - 'SHELL': '/bin/bash', 09:17:54 INFO - 'SHLVL': '1', 09:17:54 INFO - 'TERM': 'linux', 09:17:54 INFO - 'TMOUT': '86400', 09:17:54 INFO - 'USER': 'cltbld', 09:17:54 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515', 09:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:54 INFO - '_': '/tools/buildbot/bin/python'} 09:17:54 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/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 09:17:54 INFO - mozversion application_buildid: 20160223075310 09:17:54 INFO - mozversion application_changeset: 25697d5038158fadb93ec3ed76f3c2e84fd4f60f 09:17:54 INFO - mozversion application_display_name: Nightly 09:17:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:17:54 INFO - mozversion application_name: Firefox 09:17:54 INFO - mozversion application_remotingname: firefox 09:17:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:17:54 INFO - mozversion application_vendor: Mozilla 09:17:54 INFO - mozversion application_version: 47.0a1 09:17:54 INFO - mozversion platform_buildid: 20160223075310 09:17:54 INFO - mozversion platform_changeset: 25697d5038158fadb93ec3ed76f3c2e84fd4f60f 09:17:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:17:54 INFO - mozversion platform_version: 47.0a1 09:17:54 INFO - using testdate: 1456247874 09:17:54 INFO - actual date: 1456247874 09:17:54 INFO - starting webserver on 'localhost:42121' 09:17:54 INFO - SUITE-START | Running 2 tests 09:17:54 INFO - TEST-START | dromaeo_css 09:17:54 INFO - operating with platform_type : linux_ 09:17:54 INFO - Initialising browser for dromaeo_css test... 09:17:54 INFO - TEST-INFO | started process 28885 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT1OBlt/profile http://localhost:42121/getInfo.html) 09:17:58 INFO - PROCESS | 28885 | 09:17:58 INFO - PROCESS | 28885 | (process:28965): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:17:59 INFO - PROCESS | 28885 | __metrics Screen width/height:1600/1200 09:17:59 INFO - PROCESS | 28885 | colorDepth:24 09:17:59 INFO - PROCESS | 28885 | Browser inner width/height: 1024/697 09:17:59 INFO - PROCESS | 28885 | __metrics 09:17:59 ERROR - PROCESS | 28885 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 09:18:00 INFO - TEST-INFO | 28885: exit 0 09:18:00 INFO - Browser initialized. 09:18:00 INFO - Running cycle 1/1 for dromaeo_css test... 09:18:00 INFO - TEST-INFO | started process 29016 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT1OBlt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:18:02 INFO - PROCESS | 29016 | 09:18:02 INFO - PROCESS | 29016 | (process:29074): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:18:12 INFO - PROCESS | 29016 | RSS: Main: 155287552 09:18:12 INFO - PROCESS | 29016 | 09:19:02 INFO - PROCESS | 29016 | 1456247942383 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] 09:21:12 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:42121/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42121/tests/dromaeo/cssquery-ext.html) 09:21:13 INFO - PROCESS | 29016 | RSS: Main: 163053568 09:21:13 INFO - PROCESS | 29016 | 09:24:15 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:42121/tests/dromaeo/cssquery-ext.html (next: http://localhost:42121/tests/dromaeo/cssquery-jquery.html) 09:24:16 INFO - PROCESS | 29016 | RSS: Main: 160124928 09:24:16 INFO - PROCESS | 29016 | 09:27:18 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:42121/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42121/tests/dromaeo/cssquery-mootools.html) 09:27:18 INFO - PROCESS | 29016 | RSS: Main: 160755712 09:27:18 INFO - PROCESS | 29016 | 09:30:20 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:42121/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42121/tests/dromaeo/cssquery-prototype.html) 09:30:21 INFO - PROCESS | 29016 | RSS: Main: 158244864 09:30:21 INFO - PROCESS | 29016 | 09:33:23 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:42121/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42121/tests/dromaeo/cssquery-yui.html) 09:33:24 INFO - PROCESS | 29016 | RSS: Main: 159952896 09:33:24 INFO - PROCESS | 29016 | 09:36:26 INFO - PROCESS | 29016 | Cycle 1(1): loaded http://localhost:42121/tests/dromaeo/cssquery-yui.html (next: http://localhost:42121/tests/dromaeo/cssquery-dojo.html) 09:36:26 INFO - PROCESS | 29016 | RSS: Main: 162365440 09:36:26 INFO - PROCESS | 29016 | 09:36:26 INFO - PROCESS | 29016 | __start_tp_report 09:36:26 INFO - PROCESS | 29016 | _x_x_mozilla_page_load 09:36:26 INFO - PROCESS | 29016 | _x_x_mozilla_page_load_details 09:36:26 INFO - PROCESS | 29016 | |i|pagename|runs| 09:36:26 INFO - PROCESS | 29016 | |0;dojo.html;2632.7630513253803;2674.2779449548634;2712.525308071088;2718.0622685173607;2729.5769155780863;4377.627901628357;4543.840965566206;4544.909101817966;4566.246569316063;4594.448666160061;4489.147062058207;4511.413516242884;4568.543145685429;4569.840055598055;4599.172149013176;39.882567994239196;4177.707560470768;4191.643710284622;4221.451211342521;4294.4202532658;4125.463689720332;4134.958650413502;4199.91600167998;4200.1179752252065;4224.809883555232;4186.434831297766;4193.35003074524;4219.324908014733;4243.405923170728;4243.872683819475;4056.9188616227807;4160.105577300865;4251.723637963522;4258.659307255412;4299.978500107511;4183.958160418388;4185.330347144442;4185.497740271187;4188.141431006637;4209.031922657806;4451.732896026248;4456.866294011184;4466.017476155241;4471.35165401015;4471.754053527055;4632.652551058684;4820.758962051884;4853.830115945925;4860.368152140234;4888.095702295087;4788.4253889533475;4828.106800241966;4840.419149702023;4849.539293767087;4884.877878053042;4382.101669157815;4502.122086193193;4513.210188217115;4526.660500462479;4543.182227199136;4905.3132561441425;4949.307097006422;4952.331435256195;4960.082384758831;4973.8010479581135;4742.715437073718;4743.667943244009;4748.620110391161;4750.572448479654;4781.139394908881;4643.721376717408;4813.253945638432;4815.374001379868;4851.054044461296;4874.658773885794;4519.638428925678;4806.903861922742;4830.975845120752;4838.806447742051;4841.273808928689;4758;4792.161371759928;4796.136695394793;4813.927791083137;4851.151048566558;3870.2646497165447;3964.5638979712207;3980.542237642708;4031.5766844481495;4035.757854528738;3549.6272891346553;3554.235839294564;3559.394902866519;3568.5896121946307;3598.676119149289;4212.262854000538;4215.262329092397;4219.6202341789385;4243.299855523804;4274.081072569413;4826.975865120652;4854.17479028559;4855.684380515326;4860.222364421676;4905.656604037755;4163.333866581333;4163.708540402143;4190.790460476964;4192.580741925844;4194.790260486963;4216.30430978885;4226.36604509326;4244.681648876347;4248.468941382327;4283.550227226158;4581.9541804582195;4588.288815233577;4605.723656580616;4612.400387949612;4643.3963584733765;4629.305604159403;4696.365990591363;4698.8355407560575;4702.741349225688;4843.200871856105;4590.724556526619;4595.9310610341545;4637.165310244189;4640.419947506562;4653.092646933951;4709.2465205568315;4737.976310118427;4742.644301677319;4753.358296629911;4756.429228492603;4664.86005419838;4787.497312782108;4837.7097374157665;4845.200541910545;4872.707637541759;4753.310769938271;4758.1435341638835;4764.047190561971;4770.189067858541;4780.569748722632;4700.55344742249;4756.928646070242;4764.142454358249;4767.33257343979;4807.086653535817;4463.620592249695;4559.179347717442;4594.839180628662;4612.6771126022195;4637.582617564435;4690.554397332248;4742.359781429601;4752.382190315237;4766.046790641816;4798.640101992295;4461.776911154364;4655.138799322136;4655.255159174516;4661.3707149534375;4700.7179569225955 09:36:26 INFO - PROCESS | 29016 | |1;ext.html;448.4416900958307;494.47832536673815;527.8073503171343;538.3674182835168;542.1948406616173;24531.509369812593;32894.34211315772;32943.176420589494;33126;33401.16497087571;35177.64822351782;36063;36064;36407.81796091022;36461.81769091157;7517.436192285573;7774.378049756035;7779.533228006338;7782.143964163937;7788.844223115534;7539.0576177977755;7647.311741943224;7661.9616901915415;7694.807629809244;7847.293743563078;7858.960705196466;7921.326687231593;7928.445008849383;7935.444518883681;7942.444028917949;7775.105862825762;7900.091489478697;7906.6442010109395;7921.049474063092;7932.325752311061;7779.9611001945195;7858.8428231435055;7862.960685196537;7879.0151231096115;7911.881321780178;36408.635913641054;36891.81554092212;36931;36943;37011.62988370109;3003.7446817020577;3102.16241614765;3117.1116231874034;3299.851506682205;3360.9663903360897;27927.720722792714;27934.441311173865;28289.43421131566;28504.28739281514;29311.120666380044;3077.81533108012;3093.072078376478;3093.3658599987175;3120.3603261331373;3159.3997140543224;217129;217591;217774;218499.9999999984;219236;38389.424158637645;39180.804095979336;39181.60818391837;39203.60796392056;54353.72823135859;36434.8178259107;36558.26883462316;36560.45159322612;36902;36907.815460922524;13332.200067995951;13400.798988015187;13407;13496.932515337558;13503.729925401436;10475.109615682752;10601.522931468102;10677.252592318619;10685.091767199876;11012;13308.534201302908;13316.334183290797;13334.533291334757;13443.731125377633;13600.183988960694;5310.6813591184655;5496.615236933376;5506.5870059744875;5510.559155267649;5513.255710479114;882.250087425683;910.7495438754263;919.7332773495611;990.1929927109527;997.9800403992025;26017;28350.432991340058;28652.426951460853;29307.267318317212;29536.556951645744;962.6101428921298;980.0934135924241;1017.414986382818;1059.9311044782064;1074.4305518075432;12572.622821315375;12865.549705760253;13238.867611323763;13383.53157639478;15162.393504259706;318246;318731;321763;322147;323447;48975.51024489781;49142.75428622906;49518.257226141635;49603.25595116076;49781.253281200814;1191.136426091077;1219.5792451604182;1251.9374031298398;1255.629589271149;1257.0634877016498;27490.587641185797;27925.58111628368;28456.57315140316;28617.284567885137;28797.424051519272;40602;41383.37924931068;41449;41519.169616606894;41530.79234603808;243912;247156;247736;248247;248282;29874;29982.70017299799;30396.39207215799;30661.080167594115;30697.386052279275;39159.41260881032;39785.00537486586;39837;39931.60068399279;40006.799965999984;33577.16057098592;34533.30933381368;34912.127196820285;37353.62646373502;40479;29906.551401729426;30466.695333046388;30840.228994275323;30948.22629434282;31116;33461;33622.495662564594;33938;33994.83002584971;34085.31829363448;28074.43851122925;30439.543406848472;30695.469802816686;30782.692173078878;32453.539590718003;22591;23368.532629347657;24183.03267869336;24354.88691840163;24502.26493205207 09:36:26 INFO - PROCESS | 29016 | |2;jquery.html;340.81936573615974;341.2901165575602;341.55256613835877;342.5153407927782;347.0785065650698;11955.163138580303;15102.320395582197;15149.242537873117;15157.469488567902;15629.687406251867;14825.332860021297;15011.699766004673;15102.471413500529;15126.168060756654;15416.383344666228;4821;5024.673396229234;5047.4447810740785;5053.974730126344;5054.115529782292;4814.7351895645725;4941.135301322272;5029.270755740416;5042.899142017158;5073.467285934979;3437.054809927265;4958.281049247857;4983.377077865267;5270.446603106676;5583.05088135016;5646.54827613792;5700.458456446631;5707.800226992035;5741.110127930177;5749.56878234132;5014.674046186986;5049.8737531562;5746.798862039808;5997.460228579405;6038.667873266969;19289.131989060526;19505.902470487697;20009.39971800834;20523.897380513;20567.38297851052;1943.7667479902361;2122.9256976005768;2212.9446763831033;2476.8142389320874;2571.575690011146;12327.815082773766;12990.155639883471;13365.66585835362;13444.663883402894;13818.792718109236;1796.9371072012548;1908.8472922166193;1946.902654867265;1969.8719583227044;1981.296639692917;65224;66704;67278.66360668214;67937.66031169813;69003.99999999949;15005.399784008736;15683.294251758698;15705.842941570438;15749.740020798308;15779.68440631181;11977.820332695017;12356.691082723004;23251.88374058119;23262;23315.53368932612;7068.540544864567;7137.571745695275;7215.963920180366;7268.382187514015;7298.781036568911;6975.162980442379;7010.824729381806;7093.858122837514;7106.502544821917;7144.678489467987;4149.419081328617;4241.491021077491;4248.553901840324;4262.87211383659;4290.099079193342;1730.472205977189;1779.661864245789;1797.5146710388121;1830.2678928428736;1838.1268897273956;812.3338862132994;816.5549775372436;817.3502065857657;861.6338056326036;965.0542468381026;14963.95252332348;15546.455874044354;15633.374665013273;15756.133412662184;15900.840991590167;824.1881746479713;846.9661213551389;869.7651634058896;873.3624454148508;901.4140808474544;8618.956905215558;8870.334724895529;8955.149260820212;8986.820263594691;9058.637654493878;276043;281513;364438;365159;367633;59388.70305648444;61822.38177618166;63771.681141593996;66662.66668666626;68619.65690171518;927.3693888156118;944.7685317097355;952.5999080386255;955.2024059909915;958.0946006024379;13605.727885442433;13642.317884105556;13881.37533811001;13900.582982510541;14229.786553201917;29007.274818129714;30000;30244.54633180548;30644.84677576598;30688.386232275676;38649.42025869671;39914;40804.183916320915;41593.58406416018;41838.79080604699;7219.205887352492;7240.52936559122;7251;7372.741954031583;7383.8154046149275;8738.91261087381;10576.312539684895;10682.519286631965;10691.839622405825;11067.391293478937;9301.534923253676;9668.564914579001;9675.274354423305;9697.272704547046;10006.44964526958;9536.618535258513;9572.425654460476;9631.614735410505;9796.65711700087;10024;9584;9689.176420004378;9723.124918757347;9962.900370996198;10311.793764124826;7201.4238860889955;7209.747658831916;7221.711131554679;7224.963875180591;7361.043064401593;8338.874916876373;9492.667756628762;9583.329166958247;9678.467684277432;9729.854052189365 09:36:26 INFO - PROCESS | 29016 | |3;mootools.html;1347.6428746382207;1349.2174538767515;1464.5972357601665;1716.3992602589087;1725.9299234474627;6123.693815309239;7023.578585284887;7135.17945436275;7363.447741419395;7405.740799072027;7240.674169662365;7275.163356214037;7295.635218239094;7330.266973302667;7332.413406927446;2092.06902928197;2117.068489864462;2121.671140973144;2121.9363419097454;2122.628540005501;2087.759907610629;2111.862728922623;2113.693514440405;2121.2681624839483;2121.543868068365;2063.484128967758;2091.3412275133282;2106.3680895731295;2134.7331583552054;2137.690034944932;2088.1229883448987;2127.8297736181066;2133.6479480885637;2149.8065174134326;2158.3956492182215;2157.255746767363;2189.704389907358;2191.550732099916;2191.7150770399903;2199.2082850173924;7419.258074192591;7433.331000209953;7464.626768661546;7481.663325150382;7492.02603661526;4447.866564003085;4561.817527298904;4571.2457444521615;4572.062727140961;4572.382728331666;2695.2049145502124;2796.706345833699;2801.80387372884;2808.101407549585;2852.857357132156;823.6129019360891;838.2581415447312;842.8230071684953;883.5405589093699;886.8847049883474;10152.746181345452;10225.028622280872;10231.130353919925;10257.076863082284;10278.743031424274;3918.8824335269987;3921.8235179416993;3991.1020020495157;3996.1008773025837;4003.219372222447;8120.269175774209;8144.104148543655;8196.385271104691;8207.466514676527;8221.876671849926;4403.977980110143;4408.603225709638;4415.359772832985;4433.756143412079;4434.689571729948;3411.7441191910707;3962.1481381503113;4055.128147448254;4056;4077.7145599807727;3316.0714999800093;3319.8340082995755;3324.484704870749;3349.8325083745717;3373.8987830365127;978.6330126202674;993.3493561716942;997.5112195024531;998.0568362896993;1000.1148983149819;1184.265755231762;1187.1927089578996;1196.617082533581;1202.9398530073636;1227.79127548317;6945.826354341182;6948.409385202213;6993.580385176906;6998;7003.3346832050875;395.4444006171334;400.159664704119;408.5975314315397;409.5556321391324;411.36238829814266;5302;5370.624056316098;5378.623496355296;5442.482964118402;5473.616846820764;8494.74515764528;8653.091425400242;8694.565271736514;8717.825643487095;8903;8551.828963420821;8576.785580360416;8633.740987770378;8636.611352489153;8672.479651220947;6895.207051189177;7011.053507776487;7070.5404148731195;7098.183708873443;7106.964465177641;6932.306769323028;6968.965155174395;6988.615626140611;7020.122484689414;7020.22777494465;7621.3902887769955;7761.61191940412;7789.454738168501;7840.255175758294;8004.83990320202;7712.652930618024;7863.05643322782;7890.329322007464;7939.642716077675;7941.920580794118;5235.659682120802;6095.35998720128;6123.632582045091;6214.72033758491;6239.438450539473;6749.5612785168805;6768.56004359715;6815.863682726417;6828.5220034597105;6861.245263021164;6157.261128664589;6197.380261973766;6249.468795152281;6301.7164227608955;6355.936440635719;6207.751689932352;6266.686665666607;6289.339619340087;6346.079818426395;6351.96824015877;6394.360563943568;6407.070974708734;6409.134766806422;6418.261899881573;6439.484841212598;5981.3420523743225;6055.757769689163;6063.181470501426;6083;6087.634741915499;5868.2077919480325;6147.293061298008;6149.108379285068;6177.4749146321265;6180.8763824722355 09:36:26 INFO - PROCESS | 29016 | |4;prototype.html;306.19012711378406;306.3597082098415;315.0893916581081;315.7706591464261;317.3082679758126;5442.374126975399;5450.073487507123;5480.972595137024;5595.63628364156;5598.1322894951245;5403.324584426947;5458.781648734056;5469.972650136754;5470.671759694421;5478.835634930949;4032.6169013943627;4045.4336392905016;4170.061736109366;4178.916421671564;4188.099558594901;4118.217538667644;4125.236831186226;4127.669786417079;4139.875803725893;4155.667546596265;4100.425940368351;4141.813618387165;4151.709380343377;4154.8130334134885;4162.396452514398;4159;4166.062635906927;4168.124693814318;4173.9582604173875;4178.498580170369;3612.584552776438;3612.6748592626527;3615.9457608135635;3618.6743193112484;3620.2216523447323;5244.396894357122;5258.710770907599;5259.2899958505495;5262.05283049051;5267.420583735786;4626.930596041062;4749.762511874393;4752.738599377033;4761.166795810719;4761.571458568746;5710.314762228518;5711.828645140652;5726.31284245889;5736.913946290809;5739.512141467981;3907.785071821049;3909.6872250219913;3911.2568611963634;3912.5109361329833;3917;5935.169076329317;6021.548383871183;6025.246844144482;6029.939700602981;6038.033914573647;4034.8789536313957;4039.555648878621;4040.898977525527;4043.7169398142437;4046.1705350403095;4089.7750623715388;4094.324436468009;4101.056756945919;4104.548499665035;4106.445629839934;4570.954290457053;4725.503822098699;4726.527347265314;4734.147853386424;4762.14281429346;5715.599908006399;5747.540196784247;5753.108268218432;5758.88482230353;5767.250257466502;1430.4206796247536;1440.7982882396473;1443.3937746146644;1448.9275536223147;1452.3391856705173;959.3380567408466;965.6282331302499;966.1304825656824;975.0444564326999;979.0992287095889;4985.152524070917;5003.974980125076;5011.774470148852;5015.949840501621;5024.547790698854;5882.499987501024;5902.026165682614;5920.822375328747;5922.763089476372;5930.9406905931255;4964.255361695702;4964.851054468371;4975.353204083446;4978.4025916890205;4983.6760610560195;3172.841357932094;3214.61424629046;3219.1791093271067;3219.275662975812;3221.710046095816;5560.277163968658;5563.970665426909;5564.582656300794;5626.409227031103;5646.068398714248;5968.880622387528;6171.7531298748445;6193.38066193377;6195.690215489208;6218.31598524162;5631.577631677641;5668;5676.574256930747;5683.119116536944;5691.373948865621;5964.701764911824;5982.670953097621;5987.670678112746;5996.910046349221;6015.157877897011;5619.988402087663;5869.706514674163;5883.264591926009;5887.4406931341455;5910.734016969161;5505.614606977473;5632.183333416713;5635.15472679085;5638.464345887134;5649.293838270216;4021.2158629067053;4066.4916885389325;4067.247559201557;4069.941815128029;4079.4288799568676;5998.910016349845;6001.669908154919;6009.729562169626;6016.398360163948;6016.5487588431915;5720.542356611544;5747.339056008445;5777.971110144423;5792.160136780059;5793.391693872083;5555.138953462219;5742.08126699726;5751.884962300815;5762.6830524319885;5765.365809761007;5585.050541407889;5620.971895140498;5634.352049514358;5638.64672478594;5653.575981801299;5762.481376676119;5797.710114494343;5805.883882322245;5814;5830.271216097988;5624.746886390204;5635.690037048002;5636.1827535008015;5640.633358831663;5646.322441306905 09:36:26 INFO - PROCESS | 29016 | |5;yui.html;622.2408661433053;662.4336192555365;667.1993607670795;669.4610838275189;707.6426404665643;11435.885641143586;11446.370449625267;11664.41677916104;11669.416529173539;11683.766324673523;11726;12299.200551964115;12448.128630995834;12457.252564846116;12492.625221243354;610.063552446994;770.9653065612047;783.5847001089403;787.9763607091796;793.773774474275;786.5870418030522;794.3764145146062;795.6976348987376;796.34699546372;796.8844517544952;805.524740403162;814.9470284431522;820.7414664380731;821.2321479416764;823.5923218007065;792.9920700793004;810.266708628692;810.5015415519442;810.8378324335157;816.1960468938091;590.7075997381281;593.1488314269038;597.7041364524545;601.8044135655929;604.3925854516183;12520.874791252061;12524.874751252462;12567.748645027139;12572.4342404592;12581.93709031449;11856.940715296454;11873.346965916871;11996.280223186637;12019.15865889388;12038.097142714332;9650.227981761442;9722.756931076708;9797.461139637317;9858.852117218248;9862.211023118134;3201.7918835275864;3208.614966204047;3218.806871587712;3253.6258330291844;3352.0781785009076;41725;42418.36372454385;42448.78775606102;42942.35586466206;43010.56989430097;9207.90792092084;9378.577963991636;9434.3867648604;9526.809463810685;9646.565904534313;16480.42318518846;16565;16607.169641517874;16631.33474661;16668.74996875048;6169;6240.5319601030105;6244.469220116341;6395.232572091379;6574.671266436659;3532.6290739472497;3598.3522965865873;3642.3807952648112;3691.187938653492;3802.866899658499;2764.3641962348775;2778.2082106599523;2802.579613058017;2803.705610910825;2805.074325472589;492.4189456441362;498.7930009046205;501.20308709152624;501.65135231014096;506.19262276668655;473.79389965365175;489.9020195960822;518.2019689677929;558.2324304081887;604.5163868904858;8423.789405264917;8471.449355791854;8490.575471226537;8737.956310218535;8811.251043661232;465.9930101048487;499.38575552071154;597.9701014949235;607.4866737606716;628.2712054017318;3831.65515103642;4094.815733292009;4115.403266526337;4135.958640413617;4347.826086956549;46039.76980115078;46239.30641040387;47682.761586191846;50690.74654626703;51112;38791.224175516334;39089.41365879514;39161.2167756649;39719.80140099281;39858.60141398607;35620.82189589088;36130.45804312937;40525.39211911824;42412;42570.57429425728;8166;8324.6670133194;8416.410851240355;8446.197611226924;8489.36329775257;31397.8430107848;31988;32492.187695307806;33010.66989330076;33111.66888331086;36604.450933236556;37860.78183354446;40402.39396408998;40878.38682419706;40910.79544602258;10340.844887326546;10477.31897426665;10562.683119506428;10636.627718029831;10672.519736611715;11724.296542207494;11766.764664706487;11862.347570883685;11894.107941904218;11937.880621193677;10296.030745091606;10451.581936722447;10557.41934193596;10564.947175264075;10695.572177112828;10649.840252396376;10771.6229931952;10874.945625271823;11135.777284454103;11155.776884462428;10835.404052777172;10976.559593203523;11044.668659940215;11160.776784464102;11219.2146549744;8550.871736923827;8752.387332886892;9156.587953541974;9215.493147876663;9748.268879833899;8856.514513737518;9200.125988031126;9384.202342800938;9414.19979301767;9608.615655373707 09:36:26 INFO - PROCESS | 29016 | __end_tp_report 09:36:26 INFO - PROCESS | 29016 | __start_cc_report 09:36:26 INFO - PROCESS | 29016 | _x_x_mozilla_cycle_collect,309 09:36:26 INFO - PROCESS | 29016 | __end_cc_report 09:36:26 INFO - PROCESS | 29016 | __startTimestamp1456248986826__endTimestamp 09:36:26 INFO - PROCESS | 29016 | 09:36:26 INFO - PROCESS | 29016 | ------- Summary: start ------- 09:36:26 INFO - PROCESS | 29016 | Number of tests: 6 09:36:26 INFO - PROCESS | 29016 | 09:36:26 INFO - PROCESS | 29016 | [#0] dojo.html Cycles:165 Average:4443.65 Median:4595.93 stddev:561.59 (12.2%) stddev-sans-first:545.04 09:36:26 INFO - PROCESS | 29016 | Values: 2632.8 2674.3 2712.5 2718.1 2729.6 4377.6 4543.8 4544.9 4566.2 4594.4 4489.1 4511.4 4568.5 4569.8 4599.2 39.9 4177.7 4191.6 4221.5 4294.4 4125.5 4135.0 4199.9 4200.1 4224.8 4186.4 4193.4 4219.3 4243.4 4243.9 4056.9 4160.1 4251.7 4258.7 4300.0 4184.0 4185.3 4185.5 4188.1 4209.0 4451.7 4456.9 4466.0 4471.4 4471.8 4632.7 4820.8 4853.8 4860.4 4888.1 4788.4 4828.1 4840.4 4849.5 4884.9 4382.1 4502.1 4513.2 4526.7 4543.2 4905.3 4949.3 4952.3 4960.1 4973.8 4742.7 4743.7 4748.6 4750.6 4781.1 4643.7 4813.3 4815.4 4851.1 4874.7 4519.6 4806.9 4831.0 4838.8 4841.3 4758.0 4792.2 4796.1 4813.9 4851.2 3870.3 3964.6 3980.5 4031.6 4035.8 3549.6 3554.2 3559.4 3568.6 3598.7 4212.3 4215.3 4219.6 4243.3 4274.1 4827.0 4854.2 4855.7 4860.2 4905.7 4163.3 4163.7 4190.8 4192.6 4194.8 4216.3 4226.4 4244.7 4248.5 4283.6 4582.0 4588.3 4605.7 4612.4 4643.4 4629.3 4696.4 4698.8 4702.7 4843.2 4590.7 4595.9 4637.2 4640.4 4653.1 4709.2 4738.0 4742.6 4753.4 4756.4 4664.9 4787.5 4837.7 4845.2 4872.7 4753.3 4758.1 4764.0 4770.2 4780.6 4700.6 4756.9 4764.1 4767.3 4807.1 4463.6 4559.2 4594.8 4612.7 4637.6 4690.6 4742.4 4752.4 4766.0 4798.6 4461.8 4655.1 4655.3 4661.4 4700.7 09:36:26 INFO - PROCESS | 29016 | 09:36:26 INFO - PROCESS | 29016 | [#1] ext.html Cycles:180 Average:40977.30 Median:33263.58 stddev:69489.91 (208.9%) stddev-sans-first:69618.21 09:36:26 INFO - PROCESS | 29016 | Values: 448.4 494.5 527.8 538.4 542.2 24531.5 32894.3 32943.2 33126.0 33401.2 35177.6 36063.0 36064.0 36407.8 36461.8 7517.4 7774.4 7779.5 7782.1 7788.8 7539.1 7647.3 7662.0 7694.8 7847.3 7859.0 7921.3 7928.4 7935.4 7942.4 7775.1 7900.1 7906.6 7921.0 7932.3 7780.0 7858.8 7863.0 7879.0 7911.9 36408.6 36891.8 36931.0 36943.0 37011.6 3003.7 3102.2 3117.1 3299.9 3361.0 27927.7 27934.4 28289.4 28504.3 29311.1 3077.8 3093.1 3093.4 3120.4 3159.4 217129.0 217591.0 217774.0 218500.0 219236.0 38389.4 39180.8 39181.6 39203.6 54353.7 36434.8 36558.3 36560.5 36902.0 36907.8 13332.2 13400.8 13407.0 13496.9 13503.7 10475.1 10601.5 10677.3 10685.1 11012.0 13308.5 13316.3 13334.5 13443.7 13600.2 5310.7 5496.6 5506.6 5510.6 5513.3 882.3 910.7 919.7 990.2 998.0 26017.0 28350.4 28652.4 29307.3 29536.6 962.6 980.1 1017.4 1059.9 1074.4 12572.6 12865.5 13238.9 13383.5 15162.4 318246.0 318731.0 321763.0 322147.0 323447.0 48975.5 49142.8 49518.3 49603.3 49781.3 1191.1 1219.6 1251.9 1255.6 1257.1 27490.6 27925.6 28456.6 28617.3 28797.4 40602.0 41383.4 41449.0 41519.2 41530.8 243912.0 247156.0 247736.0 248247.0 248282.0 29874.0 29982.7 30396.4 30661.1 30697.4 39159.4 39785.0 39837.0 39931.6 40006.8 33577.2 34533.3 34912.1 37353.6 40479.0 29906.6 30466.7 30840.2 30948.2 31116.0 33461.0 33622.5 33938.0 33994.8 34085.3 28074.4 30439.5 30695.5 30782.7 32453.5 22591.0 23368.5 24183.0 24354.9 24502.3 09:36:26 INFO - PROCESS | 29016 | 09:36:26 INFO - PROCESS | 29016 | [#2] jquery.html Cycles:180 Average:21822.10 Median:4949.71 stddev:55030.01 (1111.8%) stddev-sans-first:55160.75 09:36:26 INFO - PROCESS | 29016 | Values: 340.8 341.3 341.6 342.5 347.1 11955.2 15102.3 15149.2 15157.5 15629.7 14825.3 15011.7 15102.5 15126.2 15416.4 4821.0 5024.7 5047.4 5054.0 5054.1 4814.7 4941.1 5029.3 5042.9 5073.5 3437.1 4958.3 4983.4 5270.4 5583.1 5646.5 5700.5 5707.8 5741.1 5749.6 5014.7 5049.9 5746.8 5997.5 6038.7 19289.1 19505.9 20009.4 20523.9 20567.4 1943.8 2122.9 2212.9 2476.8 2571.6 12327.8 12990.2 13365.7 13444.7 13818.8 1796.9 1908.8 1946.9 1969.9 1981.3 65224.0 66704.0 67278.7 67937.7 69004.0 15005.4 15683.3 15705.8 15749.7 15779.7 11977.8 12356.7 23251.9 23262.0 23315.5 7068.5 7137.6 7216.0 7268.4 7298.8 6975.2 7010.8 7093.9 7106.5 7144.7 4149.4 4241.5 4248.6 4262.9 4290.1 1730.5 1779.7 1797.5 1830.3 1838.1 812.3 816.6 817.4 861.6 965.1 14964.0 15546.5 15633.4 15756.1 15900.8 824.2 847.0 869.8 873.4 901.4 8619.0 8870.3 8955.1 8986.8 9058.6 276043.0 281513.0 364438.0 365159.0 367633.0 59388.7 61822.4 63771.7 66662.7 68619.7 927.4 944.8 952.6 955.2 958.1 13605.7 13642.3 13881.4 13900.6 14229.8 29007.3 30000.0 30244.5 30644.8 30688.4 38649.4 39914.0 40804.2 41593.6 41838.8 7219.2 7240.5 7251.0 7372.7 7383.8 8738.9 10576.3 10682.5 10691.8 11067.4 9301.5 9668.6 9675.3 9697.3 10006.4 9536.6 9572.4 9631.6 9796.7 10024.0 9584.0 9689.2 9723.1 9962.9 10311.8 7201.4 7209.7 7221.7 7225.0 7361.0 8338.9 9492.7 9583.3 9678.5 9729.9 09:36:26 INFO - PROCESS | 29016 | 09:36:26 INFO - PROCESS | 29016 | [#3] mootools.html Cycles:180 Average:5056.75 Median:6135.49 stddev:2655.67 (43.3%) stddev-sans-first:2648.48 09:36:26 INFO - PROCESS | 29016 | Values: 1347.6 1349.2 1464.6 1716.4 1725.9 6123.7 7023.6 7135.2 7363.4 7405.7 7240.7 7275.2 7295.6 7330.3 7332.4 2092.1 2117.1 2121.7 2121.9 2122.6 2087.8 2111.9 2113.7 2121.3 2121.5 2063.5 2091.3 2106.4 2134.7 2137.7 2088.1 2127.8 2133.6 2149.8 2158.4 2157.3 2189.7 2191.6 2191.7 2199.2 7419.3 7433.3 7464.6 7481.7 7492.0 4447.9 4561.8 4571.2 4572.1 4572.4 2695.2 2796.7 2801.8 2808.1 2852.9 823.6 838.3 842.8 883.5 886.9 10152.7 10225.0 10231.1 10257.1 10278.7 3918.9 3921.8 3991.1 3996.1 4003.2 8120.3 8144.1 8196.4 8207.5 8221.9 4404.0 4408.6 4415.4 4433.8 4434.7 3411.7 3962.1 4055.1 4056.0 4077.7 3316.1 3319.8 3324.5 3349.8 3373.9 978.6 993.3 997.5 998.1 1000.1 1184.3 1187.2 1196.6 1202.9 1227.8 6945.8 6948.4 6993.6 6998.0 7003.3 395.4 400.2 408.6 409.6 411.4 5302.0 5370.6 5378.6 5442.5 5473.6 8494.7 8653.1 8694.6 8717.8 8903.0 8551.8 8576.8 8633.7 8636.6 8672.5 6895.2 7011.1 7070.5 7098.2 7107.0 6932.3 6969.0 6988.6 7020.1 7020.2 7621.4 7761.6 7789.5 7840.3 8004.8 7712.7 7863.1 7890.3 7939.6 7941.9 5235.7 6095.4 6123.6 6214.7 6239.4 6749.6 6768.6 6815.9 6828.5 6861.2 6157.3 6197.4 6249.5 6301.7 6355.9 6207.8 6266.7 6289.3 6346.1 6352.0 6394.4 6407.1 6409.1 6418.3 6439.5 5981.3 6055.8 6063.2 6083.0 6087.6 5868.2 6147.3 6149.1 6177.5 6180.9 09:36:26 INFO - PROCESS | 29016 | 09:36:26 INFO - PROCESS | 29016 | [#4] prototype.html Cycles:180 Average:4740.92 Median:5474.75 stddev:1415.64 (25.9%) stddev-sans-first:1379.93 09:36:26 INFO - PROCESS | 29016 | Values: 306.2 306.4 315.1 315.8 317.3 5442.4 5450.1 5481.0 5595.6 5598.1 5403.3 5458.8 5470.0 5470.7 5478.8 4032.6 4045.4 4170.1 4178.9 4188.1 4118.2 4125.2 4127.7 4139.9 4155.7 4100.4 4141.8 4151.7 4154.8 4162.4 4159.0 4166.1 4168.1 4174.0 4178.5 3612.6 3612.7 3615.9 3618.7 3620.2 5244.4 5258.7 5259.3 5262.1 5267.4 4626.9 4749.8 4752.7 4761.2 4761.6 5710.3 5711.8 5726.3 5736.9 5739.5 3907.8 3909.7 3911.3 3912.5 3917.0 5935.2 6021.5 6025.2 6029.9 6038.0 4034.9 4039.6 4040.9 4043.7 4046.2 4089.8 4094.3 4101.1 4104.5 4106.4 4571.0 4725.5 4726.5 4734.1 4762.1 5715.6 5747.5 5753.1 5758.9 5767.3 1430.4 1440.8 1443.4 1448.9 1452.3 959.3 965.6 966.1 975.0 979.1 4985.2 5004.0 5011.8 5015.9 5024.5 5882.5 5902.0 5920.8 5922.8 5930.9 4964.3 4964.9 4975.4 4978.4 4983.7 3172.8 3214.6 3219.2 3219.3 3221.7 5560.3 5564.0 5564.6 5626.4 5646.1 5968.9 6171.8 6193.4 6195.7 6218.3 5631.6 5668.0 5676.6 5683.1 5691.4 5964.7 5982.7 5987.7 5996.9 6015.2 5620.0 5869.7 5883.3 5887.4 5910.7 5505.6 5632.2 5635.2 5638.5 5649.3 4021.2 4066.5 4067.2 4069.9 4079.4 5998.9 6001.7 6009.7 6016.4 6016.5 5720.5 5747.3 5778.0 5792.2 5793.4 5555.1 5742.1 5751.9 5762.7 5765.4 5585.1 5621.0 5634.4 5638.6 5653.6 5762.5 5797.7 5805.9 5814.0 5830.3 5624.7 5635.7 5636.2 5640.6 5646.3 09:36:26 INFO - PROCESS | 29016 | 09:36:26 INFO - PROCESS | 29016 | [#5] yui.html Cycles:180 Average:12274.44 Median:42509.68 stddev:13467.07 (31.7%) stddev-sans-first:13476.42 09:36:26 INFO - PROCESS | 29016 | Values: 622.2 662.4 667.2 669.5 707.6 11435.9 11446.4 11664.4 11669.4 11683.8 11726.0 12299.2 12448.1 12457.3 12492.6 610.1 771.0 783.6 788.0 793.8 786.6 794.4 795.7 796.3 796.9 805.5 814.9 820.7 821.2 823.6 793.0 810.3 810.5 810.8 816.2 590.7 593.1 597.7 601.8 604.4 12520.9 12524.9 12567.7 12572.4 12581.9 11856.9 11873.3 11996.3 12019.2 12038.1 9650.2 9722.8 9797.5 9858.9 9862.2 3201.8 3208.6 3218.8 3253.6 3352.1 41725.0 42418.4 42448.8 42942.4 43010.6 9207.9 9378.6 9434.4 9526.8 9646.6 16480.4 16565.0 16607.2 16631.3 16668.7 6169.0 6240.5 6244.5 6395.2 6574.7 3532.6 3598.4 3642.4 3691.2 3802.9 2764.4 2778.2 2802.6 2803.7 2805.1 492.4 498.8 501.2 501.7 506.2 473.8 489.9 518.2 558.2 604.5 8423.8 8471.4 8490.6 8738.0 8811.3 466.0 499.4 598.0 607.5 628.3 3831.7 4094.8 4115.4 4136.0 4347.8 46039.8 46239.3 47682.8 50690.7 51112.0 38791.2 39089.4 39161.2 39719.8 39858.6 35620.8 36130.5 40525.4 42412.0 42570.6 8166.0 8324.7 8416.4 8446.2 8489.4 31397.8 31988.0 32492.2 33010.7 33111.7 36604.5 37860.8 40402.4 40878.4 40910.8 10340.8 10477.3 10562.7 10636.6 10672.5 11724.3 11766.8 11862.3 11894.1 11937.9 10296.0 10451.6 10557.4 10564.9 10695.6 10649.8 10771.6 10874.9 11135.8 11155.8 10835.4 10976.6 11044.7 11160.8 11219.2 8550.9 8752.4 9156.6 9215.5 9748.3 8856.5 9200.1 9384.2 9414.2 9608.6 09:36:26 INFO - PROCESS | 29016 | -------- Summary: end -------- 09:36:26 INFO - PROCESS | 29016 | 09:36:27 INFO - TEST-INFO | 29016: exit 0 09:36:27 INFO - TEST-OK | dromaeo_css | took 1113286ms 09:36:27 INFO - TEST-START | kraken 09:36:27 INFO - operating with platform_type : linux_ 09:36:27 INFO - Initialising browser for kraken test... 09:36:27 INFO - TEST-INFO | started process 29252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz1TqvL/profile http://localhost:42121/getInfo.html) 09:36:31 INFO - PROCESS | 29252 | 09:36:31 INFO - PROCESS | 29252 | (process:29321): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:36:32 INFO - PROCESS | 29252 | __metrics Screen width/height:1600/1200 09:36:32 INFO - PROCESS | 29252 | colorDepth:24 09:36:32 INFO - PROCESS | 29252 | Browser inner width/height: 1024/697 09:36:32 INFO - PROCESS | 29252 | __metrics 09:36:32 ERROR - PROCESS | 29252 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 09:36:33 INFO - TEST-INFO | 29252: exit 0 09:36:33 INFO - Browser initialized. 09:36:33 INFO - Running cycle 1/1 for kraken test... 09:36:33 INFO - TEST-INFO | started process 29372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz1TqvL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:35 INFO - PROCESS | 29372 | 09:36:35 INFO - PROCESS | 29372 | (process:29428): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:36:45 INFO - PROCESS | 29372 | RSS: Main: 154935296 09:36:45 INFO - PROCESS | 29372 | 09:36:48 INFO - PROCESS | 29372 | Cycle 1(1): loaded http://localhost:42121/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42121/tests/kraken/driver.html?testName=audio-beat-detection) 09:36:48 INFO - PROCESS | 29372 | RSS: Main: 162316288 09:36:48 INFO - PROCESS | 29372 | 09:36:51 INFO - PROCESS | 29372 | Cycle 1(1): loaded http://localhost:42121/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42121/tests/kraken/driver.html?testName=audio-dft) 09:36:52 INFO - PROCESS | 29372 | RSS: Main: 165060608 09:36:52 INFO - PROCESS | 29372 | 09:36:55 INFO - PROCESS | 29372 | Cycle 1(1): loaded http://localhost:42121/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42121/tests/kraken/driver.html?testName=audio-fft) 09:36:55 INFO - PROCESS | 29372 | RSS: Main: 157405184 09:36:55 INFO - PROCESS | 29372 | 09:36:57 INFO - PROCESS | 29372 | Cycle 1(1): loaded http://localhost:42121/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42121/tests/kraken/driver.html?testName=audio-oscillator) 09:36:58 INFO - PROCESS | 29372 | RSS: Main: 159055872 09:36:58 INFO - PROCESS | 29372 | 09:37:00 INFO - PROCESS | 29372 | Cycle 1(1): loaded http://localhost:42121/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42121/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:37:01 INFO - PROCESS | 29372 | RSS: Main: 159166464 09:37:01 INFO - PROCESS | 29372 | 09:37:04 INFO - PROCESS | 29372 | Cycle 1(1): loaded http://localhost:42121/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42121/tests/kraken/driver.html?testName=imaging-darkroom) 09:37:05 INFO - PROCESS | 29372 | RSS: Main: 157597696 09:37:05 INFO - PROCESS | 29372 | 09:37:08 INFO - PROCESS | 29372 | Cycle 1(1): loaded http://localhost:42121/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42121/tests/kraken/driver.html?testName=imaging-desaturate) 09:37:09 INFO - PROCESS | 29372 | RSS: Main: 157483008 09:37:09 INFO - PROCESS | 29372 | 09:37:12 INFO - PROCESS | 29372 | Cycle 1(1): loaded http://localhost:42121/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42121/tests/kraken/driver.html?testName=json-parse-financial) 09:37:12 INFO - PROCESS | 29372 | RSS: Main: 159055872 09:37:12 INFO - PROCESS | 29372 | 09:37:14 INFO - PROCESS | 29372 | Cycle 1(1): loaded http://localhost:42121/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42121/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:37:15 INFO - PROCESS | 29372 | RSS: Main: 160051200 09:37:15 INFO - PROCESS | 29372 | 09:37:16 INFO - PROCESS | 29372 | Cycle 1(1): loaded http://localhost:42121/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42121/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:37:17 INFO - PROCESS | 29372 | RSS: Main: 158998528 09:37:17 INFO - PROCESS | 29372 | 09:37:19 INFO - PROCESS | 29372 | Cycle 1(1): loaded http://localhost:42121/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42121/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:37:20 INFO - PROCESS | 29372 | RSS: Main: 158552064 09:37:20 INFO - PROCESS | 29372 | 09:37:22 INFO - PROCESS | 29372 | Cycle 1(1): loaded http://localhost:42121/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42121/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:37:23 INFO - PROCESS | 29372 | RSS: Main: 160780288 09:37:23 INFO - PROCESS | 29372 | 09:37:26 INFO - PROCESS | 29372 | Cycle 1(1): loaded http://localhost:42121/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42121/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:37:26 INFO - PROCESS | 29372 | RSS: Main: 161972224 09:37:26 INFO - PROCESS | 29372 | 09:37:28 INFO - PROCESS | 29372 | Cycle 1(1): loaded http://localhost:42121/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42121/tests/kraken/driver.html?testName=ai-astar) 09:37:28 INFO - PROCESS | 29372 | RSS: Main: 161734656 09:37:28 INFO - PROCESS | 29372 | 09:37:28 INFO - PROCESS | 29372 | __start_tp_report 09:37:28 INFO - PROCESS | 29372 | _x_x_mozilla_page_load 09:37:28 INFO - PROCESS | 29372 | _x_x_mozilla_page_load_details 09:37:28 INFO - PROCESS | 29372 | |i|pagename|runs| 09:37:28 INFO - PROCESS | 29372 | |0;ai-astar;115;110;116;114;114;126;117;116;114;115 09:37:28 INFO - PROCESS | 29372 | |1;audio-beat-detection;166;134;169;169;142;157;164;133;182;144 09:37:28 INFO - PROCESS | 29372 | |2;audio-dft;163;166;166;163;166;177;163;164;167;164 09:37:28 INFO - PROCESS | 29372 | |3;audio-fft;76;75;75;147;76;75;74;76;152;83 09:37:28 INFO - PROCESS | 29372 | |4;audio-oscillator;99;99;142;97;101;99;135;98;99;146 09:37:28 INFO - PROCESS | 29372 | |5;imaging-gaussian-blur;120;117;117;116;116;115;117;116;116;120 09:37:28 INFO - PROCESS | 29372 | |6;imaging-darkroom;148;148;148;148;148;149;149;149;147;148 09:37:28 INFO - PROCESS | 29372 | |7;imaging-desaturate;97;97;97;96;96;97;97;97;97;96 09:37:28 INFO - PROCESS | 29372 | |8;json-parse-financial;66;68;67;67;67;69;68;76;65;64 09:37:28 INFO - PROCESS | 29372 | |9;json-stringify-tinderbox;70;71;70;70;71;70;72;71;70;71 09:37:28 INFO - PROCESS | 29372 | |10;stanford-crypto-aes;84;84;84;85;84;86;85;86;85;84 09:37:28 INFO - PROCESS | 29372 | |11;stanford-crypto-ccm;132;129;128;131;129;138;144;122;120;124 09:37:28 INFO - PROCESS | 29372 | |12;stanford-crypto-pbkdf2;143;139;151;159;150;141;151;153;157;142 09:37:28 INFO - PROCESS | 29372 | |13;stanford-crypto-sha256-iterative;73;72;74;70;71;71;72;74;72;73 09:37:28 INFO - PROCESS | 29372 | __end_tp_report 09:37:28 INFO - PROCESS | 29372 | __start_cc_report 09:37:28 INFO - PROCESS | 29372 | _x_x_mozilla_cycle_collect,823 09:37:28 INFO - PROCESS | 29372 | __end_cc_report 09:37:28 INFO - PROCESS | 29372 | __startTimestamp1456249048828__endTimestamp 09:37:28 INFO - PROCESS | 29372 | 09:37:28 INFO - PROCESS | 29372 | ------- Summary: start ------- 09:37:28 INFO - PROCESS | 29372 | Number of tests: 14 09:37:28 INFO - PROCESS | 29372 | 09:37:28 INFO - PROCESS | 29372 | [#0] ai-astar Cycles:10 Average:115.70 Median:115.50 stddev:4.08 (3.5%) stddev-sans-first:4.32 09:37:28 INFO - PROCESS | 29372 | Values: 115.0 110.0 116.0 114.0 114.0 126.0 117.0 116.0 114.0 115.0 09:37:28 INFO - PROCESS | 29372 | 09:37:28 INFO - PROCESS | 29372 | [#1] audio-beat-detection Cycles:10 Average:156.00 Median:165.00 stddev:16.77 (10.2%) stddev-sans-first:17.40 09:37:28 INFO - PROCESS | 29372 | Values: 166.0 134.0 169.0 169.0 142.0 157.0 164.0 133.0 182.0 144.0 09:37:28 INFO - PROCESS | 29372 | 09:37:28 INFO - PROCESS | 29372 | [#2] audio-dft Cycles:10 Average:165.90 Median:166.00 stddev:4.18 (2.5%) stddev-sans-first:4.29 09:37:28 INFO - PROCESS | 29372 | Values: 163.0 166.0 166.0 163.0 166.0 177.0 163.0 164.0 167.0 164.0 09:37:28 INFO - PROCESS | 29372 | 09:37:28 INFO - PROCESS | 29372 | [#3] audio-fft Cycles:10 Average:90.90 Median:75.50 stddev:31.01 (41.1%) stddev-sans-first:32.42 09:37:28 INFO - PROCESS | 29372 | Values: 76.0 75.0 75.0 147.0 76.0 75.0 74.0 76.0 152.0 83.0 09:37:28 INFO - PROCESS | 29372 | 09:37:28 INFO - PROCESS | 29372 | [#4] audio-oscillator Cycles:10 Average:111.50 Median:98.50 stddev:20.55 (20.9%) stddev-sans-first:21.29 09:37:28 INFO - PROCESS | 29372 | Values: 99.0 99.0 142.0 97.0 101.0 99.0 135.0 98.0 99.0 146.0 09:37:28 INFO - PROCESS | 29372 | 09:37:28 INFO - PROCESS | 29372 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:1.70 (1.5%) stddev-sans-first:1.41 09:37:28 INFO - PROCESS | 29372 | Values: 120.0 117.0 117.0 116.0 116.0 115.0 117.0 116.0 116.0 120.0 09:37:28 INFO - PROCESS | 29372 | 09:37:28 INFO - PROCESS | 29372 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 09:37:28 INFO - PROCESS | 29372 | Values: 148.0 148.0 148.0 148.0 148.0 149.0 149.0 149.0 147.0 148.0 09:37:28 INFO - PROCESS | 29372 | 09:37:28 INFO - PROCESS | 29372 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:37:28 INFO - PROCESS | 29372 | Values: 97.0 97.0 97.0 96.0 96.0 97.0 97.0 97.0 97.0 96.0 09:37:28 INFO - PROCESS | 29372 | 09:37:28 INFO - PROCESS | 29372 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:67.50 stddev:3.27 (4.8%) stddev-sans-first:3.41 09:37:28 INFO - PROCESS | 29372 | Values: 66.0 68.0 67.0 67.0 67.0 69.0 68.0 76.0 65.0 64.0 09:37:28 INFO - PROCESS | 29372 | 09:37:28 INFO - PROCESS | 29372 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 09:37:28 INFO - PROCESS | 29372 | Values: 70.0 71.0 70.0 70.0 71.0 70.0 72.0 71.0 70.0 71.0 09:37:28 INFO - PROCESS | 29372 | 09:37:28 INFO - PROCESS | 29372 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:85.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 09:37:28 INFO - PROCESS | 29372 | Values: 84.0 84.0 84.0 85.0 84.0 86.0 85.0 86.0 85.0 84.0 09:37:28 INFO - PROCESS | 29372 | 09:37:28 INFO - PROCESS | 29372 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:130.00 stddev:7.23 (5.6%) stddev-sans-first:7.62 09:37:28 INFO - PROCESS | 29372 | Values: 132.0 129.0 128.0 131.0 129.0 138.0 144.0 122.0 120.0 124.0 09:37:28 INFO - PROCESS | 29372 | 09:37:28 INFO - PROCESS | 29372 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.60 Median:151.00 stddev:6.96 (4.6%) stddev-sans-first:7.08 09:37:28 INFO - PROCESS | 29372 | Values: 143.0 139.0 151.0 159.0 150.0 141.0 151.0 153.0 157.0 142.0 09:37:28 INFO - PROCESS | 29372 | 09:37:28 INFO - PROCESS | 29372 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:72.50 stddev:1.32 (1.8%) stddev-sans-first:1.36 09:37:28 INFO - PROCESS | 29372 | Values: 73.0 72.0 74.0 70.0 71.0 71.0 72.0 74.0 72.0 73.0 09:37:28 INFO - PROCESS | 29372 | -------- Summary: end -------- 09:37:28 INFO - PROCESS | 29372 | 09:37:29 INFO - TEST-INFO | 29372: exit 0 09:37:29 INFO - TEST-OK | kraken | took 62302ms 09:37:29 INFO - SUITE-END | took 1175s 09:37:29 INFO - Completed test suite (00:19:35) 09:37:29 INFO - Working with test: dromaeo_css 09:37:29 INFO - Generating results file: dromaeo_css 09:37:29 INFO - Working with test: kraken 09:37:29 INFO - Generating results file: kraken 09:37:29 INFO - javascript benchmark 09:37:29 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:37:30 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 09:37:30 INFO - process_Request line: dromaeo_css 6224.96 graph.html#tests=[[72,94,43]] 09:37:30 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:37:30 INFO - process_Request line: kraken 1575.40 graph.html#tests=[[232,94,43]] 09:37:30 INFO - RETURN: dromaeo_css: 6224.96 09:37:30 INFO - RETURN: kraken: 1575.40 09:37:30 INFO - javascript benchmark 09:37:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2632.7630513253803, 2674.2779449548634, 2712.525308071088, 2718.0622685173607, 2729.5769155780863, 4377.627901628357, 4543.840965566206, 4544.909101817966, 4566.246569316063, 4594.448666160061, 4489.147062058207, 4511.413516242884, 4568.543145685429, 4569.840055598055, 4599.172149013176, 39.882567994239196, 4177.707560470768, 4191.643710284622, 4221.451211342521, 4294.4202532658, 4125.463689720332, 4134.958650413502, 4199.91600167998, 4200.1179752252065, 4224.809883555232, 4186.434831297766, 4193.35003074524, 4219.324908014733, 4243.405923170728, 4243.872683819475, 4056.9188616227807, 4160.105577300865, 4251.723637963522, 4258.659307255412, 4299.978500107511, 4183.958160418388, 4185.330347144442, 4185.497740271187, 4188.141431006637, 4209.031922657806, 4451.732896026248, 4456.866294011184, 4466.017476155241, 4471.35165401015, 4471.754053527055, 4632.652551058684, 4820.758962051884, 4853.830115945925, 4860.368152140234, 4888.095702295087, 4788.4253889533475, 4828.106800241966, 4840.419149702023, 4849.539293767087, 4884.877878053042, 4382.101669157815, 4502.122086193193, 4513.210188217115, 4526.660500462479, 4543.182227199136, 4905.3132561441425, 4949.307097006422, 4952.331435256195, 4960.082384758831, 4973.8010479581135, 4742.715437073718, 4743.667943244009, 4748.620110391161, 4750.572448479654, 4781.139394908881, 4643.721376717408, 4813.253945638432, 4815.374001379868, 4851.054044461296, 4874.658773885794, 4519.638428925678, 4806.903861922742, 4830.975845120752, 4838.806447742051, 4841.273808928689, 4758.0, 4792.161371759928, 4796.136695394793, 4813.927791083137, 4851.151048566558, 3870.2646497165447, 3964.5638979712207, 3980.542237642708, 4031.5766844481495, 4035.757854528738, 3549.6272891346553, 3554.235839294564, 3559.394902866519, 3568.5896121946307, 3598.676119149289, 4212.262854000538, 4215.262329092397, 4219.6202341789385, 4243.299855523804, 4274.081072569413, 4826.975865120652, 4854.17479028559, 4855.684380515326, 4860.222364421676, 4905.656604037755, 4163.333866581333, 4163.708540402143, 4190.790460476964, 4192.580741925844, 4194.790260486963, 4216.30430978885, 4226.36604509326, 4244.681648876347, 4248.468941382327, 4283.550227226158, 4581.9541804582195, 4588.288815233577, 4605.723656580616, 4612.400387949612, 4643.3963584733765, 4629.305604159403, 4696.365990591363, 4698.8355407560575, 4702.741349225688, 4843.200871856105, 4590.724556526619, 4595.9310610341545, 4637.165310244189, 4640.419947506562, 4653.092646933951, 4709.2465205568315, 4737.976310118427, 4742.644301677319, 4753.358296629911, 4756.429228492603, 4664.86005419838, 4787.497312782108, 4837.7097374157665, 4845.200541910545, 4872.707637541759, 4753.310769938271, 4758.1435341638835, 4764.047190561971, 4770.189067858541, 4780.569748722632, 4700.55344742249, 4756.928646070242, 4764.142454358249, 4767.33257343979, 4807.086653535817, 4463.620592249695, 4559.179347717442, 4594.839180628662, 4612.6771126022195, 4637.582617564435, 4690.554397332248, 4742.359781429601, 4752.382190315237, 4766.046790641816, 4798.640101992295, 4461.776911154364, 4655.138799322136, 4655.255159174516, 4661.3707149534375, 4700.7179569225955], "unit": "score", "name": "dojo.html", "value": 4413.457320897742}, {"lowerIsBetter": false, "replicates": [448.4416900958307, 494.47832536673815, 527.8073503171343, 538.3674182835168, 542.1948406616173, 24531.509369812593, 32894.34211315772, 32943.176420589494, 33126.0, 33401.16497087571, 35177.64822351782, 36063.0, 36064.0, 36407.81796091022, 36461.81769091157, 7517.436192285573, 7774.378049756035, 7779.533228006338, 7782.143964163937, 7788.844223115534, 7539.0576177977755, 7647.311741943224, 7661.9616901915415, 7694.807629809244, 7847.293743563078, 7858.960705196466, 7921.326687231593, 7928.445008849383, 7935.444518883681, 7942.444028917949, 7775.105862825762, 7900.091489478697, 7906.6442010109395, 7921.049474063092, 7932.325752311061, 7779.9611001945195, 7858.8428231435055, 7862.960685196537, 7879.0151231096115, 7911.881321780178, 36408.635913641054, 36891.81554092212, 36931.0, 36943.0, 37011.62988370109, 3003.7446817020577, 3102.16241614765, 3117.1116231874034, 3299.851506682205, 3360.9663903360897, 27927.720722792714, 27934.441311173865, 28289.43421131566, 28504.28739281514, 29311.120666380044, 3077.81533108012, 3093.072078376478, 3093.3658599987175, 3120.3603261331373, 3159.3997140543224, 217129.0, 217591.0, 217774.0, 218499.9999999984, 219236.0, 38389.424158637645, 39180.804095979336, 39181.60818391837, 39203.60796392056, 54353.72823135859, 36434.8178259107, 36558.26883462316, 36560.45159322612, 36902.0, 36907.815460922524, 13332.200067995951, 13400.798988015187, 13407.0, 13496.932515337558, 13503.729925401436, 10475.109615682752, 10601.522931468102, 10677.252592318619, 10685.091767199876, 11012.0, 13308.534201302908, 13316.334183290797, 13334.533291334757, 13443.731125377633, 13600.183988960694, 5310.6813591184655, 5496.615236933376, 5506.5870059744875, 5510.559155267649, 5513.255710479114, 882.250087425683, 910.7495438754263, 919.7332773495611, 990.1929927109527, 997.9800403992025, 26017.0, 28350.432991340058, 28652.426951460853, 29307.267318317212, 29536.556951645744, 962.6101428921298, 980.0934135924241, 1017.414986382818, 1059.9311044782064, 1074.4305518075432, 12572.622821315375, 12865.549705760253, 13238.867611323763, 13383.53157639478, 15162.393504259706, 318246.0, 318731.0, 321763.0, 322147.0, 323447.0, 48975.51024489781, 49142.75428622906, 49518.257226141635, 49603.25595116076, 49781.253281200814, 1191.136426091077, 1219.5792451604182, 1251.9374031298398, 1255.629589271149, 1257.0634877016498, 27490.587641185797, 27925.58111628368, 28456.57315140316, 28617.284567885137, 28797.424051519272, 40602.0, 41383.37924931068, 41449.0, 41519.169616606894, 41530.79234603808, 243912.0, 247156.0, 247736.0, 248247.0, 248282.0, 29874.0, 29982.70017299799, 30396.39207215799, 30661.080167594115, 30697.386052279275, 39159.41260881032, 39785.00537486586, 39837.0, 39931.60068399279, 40006.799965999984, 33577.16057098592, 34533.30933381368, 34912.127196820285, 37353.62646373502, 40479.0, 29906.551401729426, 30466.695333046388, 30840.228994275323, 30948.22629434282, 31116.0, 33461.0, 33622.495662564594, 33938.0, 33994.83002584971, 34085.31829363448, 28074.43851122925, 30439.543406848472, 30695.469802816686, 30782.692173078878, 32453.539590718003, 22591.0, 23368.532629347657, 24183.03267869336, 24354.88691840163, 24502.26493205207], "unit": "score", "name": "ext.html", "value": 16280.961349455014}, {"lowerIsBetter": false, "replicates": [340.81936573615974, 341.2901165575602, 341.55256613835877, 342.5153407927782, 347.0785065650698, 11955.163138580303, 15102.320395582197, 15149.242537873117, 15157.469488567902, 15629.687406251867, 14825.332860021297, 15011.699766004673, 15102.471413500529, 15126.168060756654, 15416.383344666228, 4821.0, 5024.673396229234, 5047.4447810740785, 5053.974730126344, 5054.115529782292, 4814.7351895645725, 4941.135301322272, 5029.270755740416, 5042.899142017158, 5073.467285934979, 3437.054809927265, 4958.281049247857, 4983.377077865267, 5270.446603106676, 5583.05088135016, 5646.54827613792, 5700.458456446631, 5707.800226992035, 5741.110127930177, 5749.56878234132, 5014.674046186986, 5049.8737531562, 5746.798862039808, 5997.460228579405, 6038.667873266969, 19289.131989060526, 19505.902470487697, 20009.39971800834, 20523.897380513, 20567.38297851052, 1943.7667479902361, 2122.9256976005768, 2212.9446763831033, 2476.8142389320874, 2571.575690011146, 12327.815082773766, 12990.155639883471, 13365.66585835362, 13444.663883402894, 13818.792718109236, 1796.9371072012548, 1908.8472922166193, 1946.902654867265, 1969.8719583227044, 1981.296639692917, 65224.0, 66704.0, 67278.66360668214, 67937.66031169813, 69003.99999999949, 15005.399784008736, 15683.294251758698, 15705.842941570438, 15749.740020798308, 15779.68440631181, 11977.820332695017, 12356.691082723004, 23251.88374058119, 23262.0, 23315.53368932612, 7068.540544864567, 7137.571745695275, 7215.963920180366, 7268.382187514015, 7298.781036568911, 6975.162980442379, 7010.824729381806, 7093.858122837514, 7106.502544821917, 7144.678489467987, 4149.419081328617, 4241.491021077491, 4248.553901840324, 4262.87211383659, 4290.099079193342, 1730.472205977189, 1779.661864245789, 1797.5146710388121, 1830.2678928428736, 1838.1268897273956, 812.3338862132994, 816.5549775372436, 817.3502065857657, 861.6338056326036, 965.0542468381026, 14963.95252332348, 15546.455874044354, 15633.374665013273, 15756.133412662184, 15900.840991590167, 824.1881746479713, 846.9661213551389, 869.7651634058896, 873.3624454148508, 901.4140808474544, 8618.956905215558, 8870.334724895529, 8955.149260820212, 8986.820263594691, 9058.637654493878, 276043.0, 281513.0, 364438.0, 365159.0, 367633.0, 59388.70305648444, 61822.38177618166, 63771.681141593996, 66662.66668666626, 68619.65690171518, 927.3693888156118, 944.7685317097355, 952.5999080386255, 955.2024059909915, 958.0946006024379, 13605.727885442433, 13642.317884105556, 13881.37533811001, 13900.582982510541, 14229.786553201917, 29007.274818129714, 30000.0, 30244.54633180548, 30644.84677576598, 30688.386232275676, 38649.42025869671, 39914.0, 40804.183916320915, 41593.58406416018, 41838.79080604699, 7219.205887352492, 7240.52936559122, 7251.0, 7372.741954031583, 7383.8154046149275, 8738.91261087381, 10576.312539684895, 10682.519286631965, 10691.839622405825, 11067.391293478937, 9301.534923253676, 9668.564914579001, 9675.274354423305, 9697.272704547046, 10006.44964526958, 9536.618535258513, 9572.425654460476, 9631.614735410505, 9796.65711700087, 10024.0, 9584.0, 9689.176420004378, 9723.124918757347, 9962.900370996198, 10311.793764124826, 7201.4238860889955, 7209.747658831916, 7221.711131554679, 7224.963875180591, 7361.043064401593, 8338.874916876373, 9492.667756628762, 9583.329166958247, 9678.467684277432, 9729.854052189365], "unit": "score", "name": "jquery.html", "value": 8057.6224254600265}, {"lowerIsBetter": false, "replicates": [1347.6428746382207, 1349.2174538767515, 1464.5972357601665, 1716.3992602589087, 1725.9299234474627, 6123.693815309239, 7023.578585284887, 7135.17945436275, 7363.447741419395, 7405.740799072027, 7240.674169662365, 7275.163356214037, 7295.635218239094, 7330.266973302667, 7332.413406927446, 2092.06902928197, 2117.068489864462, 2121.671140973144, 2121.9363419097454, 2122.628540005501, 2087.759907610629, 2111.862728922623, 2113.693514440405, 2121.2681624839483, 2121.543868068365, 2063.484128967758, 2091.3412275133282, 2106.3680895731295, 2134.7331583552054, 2137.690034944932, 2088.1229883448987, 2127.8297736181066, 2133.6479480885637, 2149.8065174134326, 2158.3956492182215, 2157.255746767363, 2189.704389907358, 2191.550732099916, 2191.7150770399903, 2199.2082850173924, 7419.258074192591, 7433.331000209953, 7464.626768661546, 7481.663325150382, 7492.02603661526, 4447.866564003085, 4561.817527298904, 4571.2457444521615, 4572.062727140961, 4572.382728331666, 2695.2049145502124, 2796.706345833699, 2801.80387372884, 2808.101407549585, 2852.857357132156, 823.6129019360891, 838.2581415447312, 842.8230071684953, 883.5405589093699, 886.8847049883474, 10152.746181345452, 10225.028622280872, 10231.130353919925, 10257.076863082284, 10278.743031424274, 3918.8824335269987, 3921.8235179416993, 3991.1020020495157, 3996.1008773025837, 4003.219372222447, 8120.269175774209, 8144.104148543655, 8196.385271104691, 8207.466514676527, 8221.876671849926, 4403.977980110143, 4408.603225709638, 4415.359772832985, 4433.756143412079, 4434.689571729948, 3411.7441191910707, 3962.1481381503113, 4055.128147448254, 4056.0, 4077.7145599807727, 3316.0714999800093, 3319.8340082995755, 3324.484704870749, 3349.8325083745717, 3373.8987830365127, 978.6330126202674, 993.3493561716942, 997.5112195024531, 998.0568362896993, 1000.1148983149819, 1184.265755231762, 1187.1927089578996, 1196.617082533581, 1202.9398530073636, 1227.79127548317, 6945.826354341182, 6948.409385202213, 6993.580385176906, 6998.0, 7003.3346832050875, 395.4444006171334, 400.159664704119, 408.5975314315397, 409.5556321391324, 411.36238829814266, 5302.0, 5370.624056316098, 5378.623496355296, 5442.482964118402, 5473.616846820764, 8494.74515764528, 8653.091425400242, 8694.565271736514, 8717.825643487095, 8903.0, 8551.828963420821, 8576.785580360416, 8633.740987770378, 8636.611352489153, 8672.479651220947, 6895.207051189177, 7011.053507776487, 7070.5404148731195, 7098.183708873443, 7106.964465177641, 6932.306769323028, 6968.965155174395, 6988.615626140611, 7020.122484689414, 7020.22777494465, 7621.3902887769955, 7761.61191940412, 7789.454738168501, 7840.255175758294, 8004.83990320202, 7712.652930618024, 7863.05643322782, 7890.329322007464, 7939.642716077675, 7941.920580794118, 5235.659682120802, 6095.35998720128, 6123.632582045091, 6214.72033758491, 6239.438450539473, 6749.5612785168805, 6768.56004359715, 6815.863682726417, 6828.5220034597105, 6861.245263021164, 6157.261128664589, 6197.380261973766, 6249.468795152281, 6301.7164227608955, 6355.936440635719, 6207.751689932352, 6266.686665666607, 6289.339619340087, 6346.079818426395, 6351.96824015877, 6394.360563943568, 6407.070974708734, 6409.134766806422, 6418.261899881573, 6439.484841212598, 5981.3420523743225, 6055.757769689163, 6063.181470501426, 6083.0, 6087.634741915499, 5868.2077919480325, 6147.293061298008, 6149.108379285068, 6177.4749146321265, 6180.8763824722355], "unit": "score", "name": "mootools.html", "value": 4062.6494716619}, {"lowerIsBetter": false, "replicates": [306.19012711378406, 306.3597082098415, 315.0893916581081, 315.7706591464261, 317.3082679758126, 5442.374126975399, 5450.073487507123, 5480.972595137024, 5595.63628364156, 5598.1322894951245, 5403.324584426947, 5458.781648734056, 5469.972650136754, 5470.671759694421, 5478.835634930949, 4032.6169013943627, 4045.4336392905016, 4170.061736109366, 4178.916421671564, 4188.099558594901, 4118.217538667644, 4125.236831186226, 4127.669786417079, 4139.875803725893, 4155.667546596265, 4100.425940368351, 4141.813618387165, 4151.709380343377, 4154.8130334134885, 4162.396452514398, 4159.0, 4166.062635906927, 4168.124693814318, 4173.9582604173875, 4178.498580170369, 3612.584552776438, 3612.6748592626527, 3615.9457608135635, 3618.6743193112484, 3620.2216523447323, 5244.396894357122, 5258.710770907599, 5259.2899958505495, 5262.05283049051, 5267.420583735786, 4626.930596041062, 4749.762511874393, 4752.738599377033, 4761.166795810719, 4761.571458568746, 5710.314762228518, 5711.828645140652, 5726.31284245889, 5736.913946290809, 5739.512141467981, 3907.785071821049, 3909.6872250219913, 3911.2568611963634, 3912.5109361329833, 3917.0, 5935.169076329317, 6021.548383871183, 6025.246844144482, 6029.939700602981, 6038.033914573647, 4034.8789536313957, 4039.555648878621, 4040.898977525527, 4043.7169398142437, 4046.1705350403095, 4089.7750623715388, 4094.324436468009, 4101.056756945919, 4104.548499665035, 4106.445629839934, 4570.954290457053, 4725.503822098699, 4726.527347265314, 4734.147853386424, 4762.14281429346, 5715.599908006399, 5747.540196784247, 5753.108268218432, 5758.88482230353, 5767.250257466502, 1430.4206796247536, 1440.7982882396473, 1443.3937746146644, 1448.9275536223147, 1452.3391856705173, 959.3380567408466, 965.6282331302499, 966.1304825656824, 975.0444564326999, 979.0992287095889, 4985.152524070917, 5003.974980125076, 5011.774470148852, 5015.949840501621, 5024.547790698854, 5882.499987501024, 5902.026165682614, 5920.822375328747, 5922.763089476372, 5930.9406905931255, 4964.255361695702, 4964.851054468371, 4975.353204083446, 4978.4025916890205, 4983.6760610560195, 3172.841357932094, 3214.61424629046, 3219.1791093271067, 3219.275662975812, 3221.710046095816, 5560.277163968658, 5563.970665426909, 5564.582656300794, 5626.409227031103, 5646.068398714248, 5968.880622387528, 6171.7531298748445, 6193.38066193377, 6195.690215489208, 6218.31598524162, 5631.577631677641, 5668.0, 5676.574256930747, 5683.119116536944, 5691.373948865621, 5964.701764911824, 5982.670953097621, 5987.670678112746, 5996.910046349221, 6015.157877897011, 5619.988402087663, 5869.706514674163, 5883.264591926009, 5887.4406931341455, 5910.734016969161, 5505.614606977473, 5632.183333416713, 5635.15472679085, 5638.464345887134, 5649.293838270216, 4021.2158629067053, 4066.4916885389325, 4067.247559201557, 4069.941815128029, 4079.4288799568676, 5998.910016349845, 6001.669908154919, 6009.729562169626, 6016.398360163948, 6016.5487588431915, 5720.542356611544, 5747.339056008445, 5777.971110144423, 5792.160136780059, 5793.391693872083, 5555.138953462219, 5742.08126699726, 5751.884962300815, 5762.6830524319885, 5765.365809761007, 5585.050541407889, 5620.971895140498, 5634.352049514358, 5638.64672478594, 5653.575981801299, 5762.481376676119, 5797.710114494343, 5805.883882322245, 5814.0, 5830.271216097988, 5624.746886390204, 5635.690037048002, 5636.1827535008015, 5640.633358831663, 5646.322441306905], "unit": "score", "name": "prototype.html", "value": 4284.918576844798}, {"lowerIsBetter": false, "replicates": [622.2408661433053, 662.4336192555365, 667.1993607670795, 669.4610838275189, 707.6426404665643, 11435.885641143586, 11446.370449625267, 11664.41677916104, 11669.416529173539, 11683.766324673523, 11726.0, 12299.200551964115, 12448.128630995834, 12457.252564846116, 12492.625221243354, 610.063552446994, 770.9653065612047, 783.5847001089403, 787.9763607091796, 793.773774474275, 786.5870418030522, 794.3764145146062, 795.6976348987376, 796.34699546372, 796.8844517544952, 805.524740403162, 814.9470284431522, 820.7414664380731, 821.2321479416764, 823.5923218007065, 792.9920700793004, 810.266708628692, 810.5015415519442, 810.8378324335157, 816.1960468938091, 590.7075997381281, 593.1488314269038, 597.7041364524545, 601.8044135655929, 604.3925854516183, 12520.874791252061, 12524.874751252462, 12567.748645027139, 12572.4342404592, 12581.93709031449, 11856.940715296454, 11873.346965916871, 11996.280223186637, 12019.15865889388, 12038.097142714332, 9650.227981761442, 9722.756931076708, 9797.461139637317, 9858.852117218248, 9862.211023118134, 3201.7918835275864, 3208.614966204047, 3218.806871587712, 3253.6258330291844, 3352.0781785009076, 41725.0, 42418.36372454385, 42448.78775606102, 42942.35586466206, 43010.56989430097, 9207.90792092084, 9378.577963991636, 9434.3867648604, 9526.809463810685, 9646.565904534313, 16480.42318518846, 16565.0, 16607.169641517874, 16631.33474661, 16668.74996875048, 6169.0, 6240.5319601030105, 6244.469220116341, 6395.232572091379, 6574.671266436659, 3532.6290739472497, 3598.3522965865873, 3642.3807952648112, 3691.187938653492, 3802.866899658499, 2764.3641962348775, 2778.2082106599523, 2802.579613058017, 2803.705610910825, 2805.074325472589, 492.4189456441362, 498.7930009046205, 501.20308709152624, 501.65135231014096, 506.19262276668655, 473.79389965365175, 489.9020195960822, 518.2019689677929, 558.2324304081887, 604.5163868904858, 8423.789405264917, 8471.449355791854, 8490.575471226537, 8737.956310218535, 8811.251043661232, 465.9930101048487, 499.38575552071154, 597.9701014949235, 607.4866737606716, 628.2712054017318, 3831.65515103642, 4094.815733292009, 4115.403266526337, 4135.958640413617, 4347.826086956549, 46039.76980115078, 46239.30641040387, 47682.761586191846, 50690.74654626703, 51112.0, 38791.224175516334, 39089.41365879514, 39161.2167756649, 39719.80140099281, 39858.60141398607, 35620.82189589088, 36130.45804312937, 40525.39211911824, 42412.0, 42570.57429425728, 8166.0, 8324.6670133194, 8416.410851240355, 8446.197611226924, 8489.36329775257, 31397.8430107848, 31988.0, 32492.187695307806, 33010.66989330076, 33111.66888331086, 36604.450933236556, 37860.78183354446, 40402.39396408998, 40878.38682419706, 40910.79544602258, 10340.844887326546, 10477.31897426665, 10562.683119506428, 10636.627718029831, 10672.519736611715, 11724.296542207494, 11766.764664706487, 11862.347570883685, 11894.107941904218, 11937.880621193677, 10296.030745091606, 10451.581936722447, 10557.41934193596, 10564.947175264075, 10695.572177112828, 10649.840252396376, 10771.6229931952, 10874.945625271823, 11135.777284454103, 11155.776884462428, 10835.404052777172, 10976.559593203523, 11044.668659940215, 11160.776784464102, 11219.2146549744, 8550.871736923827, 8752.387332886892, 9156.587953541974, 9215.493147876663, 9748.268879833899, 8856.514513737518, 9200.125988031126, 9384.202342800938, 9414.19979301767, 9608.615655373707], "unit": "score", "name": "yui.html", "value": 5772.405241187751}], "name": "dromaeo_css", "value": 6224.957826266976}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 116.0, 114.0, 114.0, 126.0, 117.0, 116.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.7}, {"lowerIsBetter": true, "replicates": [166.0, 134.0, 169.0, 169.0, 142.0, 157.0, 164.0, 133.0, 182.0, 144.0], "unit": "score", "name": "audio-beat-detection", "value": 156.0}, {"lowerIsBetter": true, "replicates": [163.0, 166.0, 166.0, 163.0, 166.0, 177.0, 163.0, 164.0, 167.0, 164.0], "unit": "score", "name": "audio-dft", "value": 165.9}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 75.0, 147.0, 76.0, 75.0, 74.0, 76.0, 152.0, 83.0], "unit": "score", "name": "audio-fft", "value": 90.9}, {"lowerIsBetter": true, "replicates": [99.0, 99.0, 142.0, 97.0, 101.0, 99.0, 135.0, 98.0, 99.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 111.5}, {"lowerIsBetter": true, "replicates": [120.0, 117.0, 117.0, 116.0, 116.0, 115.0, 117.0, 116.0, 116.0, 120.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 149.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 96.0, 96.0, 97.0, 97.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 67.0, 67.0, 69.0, 68.0, 76.0, 65.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 67.7}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 70.0, 70.0, 71.0, 70.0, 72.0, 71.0, 70.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.6}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 84.0, 85.0, 84.0, 86.0, 85.0, 86.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [132.0, 129.0, 128.0, 131.0, 129.0, 138.0, 144.0, 122.0, 120.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.7}, {"lowerIsBetter": true, "replicates": [143.0, 139.0, 151.0, 159.0, 150.0, 141.0, 151.0, 153.0, 157.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.6}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 74.0, 70.0, 71.0, 71.0, 72.0, 74.0, 72.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.2}], "name": "kraken", "value": 1575.4}]} 09:37:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1575.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6224.96"}}} 09:37:30 INFO - Return code: 0 09:37:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:37:30 ERROR - # TBPL SUCCESS # 09:37:30 INFO - Running post-action listener: _resource_record_post_action 09:37:30 INFO - Running post-run listener: _resource_record_post_run 09:37:31 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 533475328; Read time: 0; Write time: 646752 09:37:31 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 241012736; Read time: 0; Write time: 361160 09:37:31 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 292462592; Read time: 0; Write time: 285592 09:37:31 INFO - Running post-run listener: _upload_blobber_files 09:37:31 INFO - Blob upload gear active. 09:37:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:37:31 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 09:37:31 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'] 09:37:31 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 09:37:31 INFO - (blobuploader) - INFO - Open directory for files ... 09:37:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:37:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:37:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:32 INFO - (blobuploader) - INFO - Done attempting. 09:37:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:37:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:37:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:33 INFO - (blobuploader) - INFO - Done attempting. 09:37:33 INFO - (blobuploader) - INFO - Iteration through files over. 09:37:33 INFO - Return code: 0 09:37:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:37:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:37:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ba67964c651b853d73b1c5c4cf42120fc1610845b581ea02d17ffabed93d102fddc321d021c7ce1a55527d803cdbd5601a3a6dbf9f3994de68b9ce7c7024caa0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dbef93ba46f1024b9d3d35ecaf0a5a05e282173c57cf713980a9cebf3590006ba1194fa67acb2bc0511aed91648af977f15d5f5bb4e4229355104bd068288b2a"} 09:37:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:37:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:37:33 INFO - Contents: 09:37:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ba67964c651b853d73b1c5c4cf42120fc1610845b581ea02d17ffabed93d102fddc321d021c7ce1a55527d803cdbd5601a3a6dbf9f3994de68b9ce7c7024caa0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dbef93ba46f1024b9d3d35ecaf0a5a05e282173c57cf713980a9cebf3590006ba1194fa67acb2bc0511aed91648af977f15d5f5bb4e4229355104bd068288b2a"} 09:37:33 INFO - Running post-run listener: copy_logs_to_upload_dir 09:37:33 INFO - Copying logs to upload dir... 09:37:33 INFO - mkdir: /builds/slave/test/build/upload/logs 09:37:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.560658 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-02-23 09:37:33.307573) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 09:37:33.311289) ========= 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=652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515 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/ba67964c651b853d73b1c5c4cf42120fc1610845b581ea02d17ffabed93d102fddc321d021c7ce1a55527d803cdbd5601a3a6dbf9f3994de68b9ce7c7024caa0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dbef93ba46f1024b9d3d35ecaf0a5a05e282173c57cf713980a9cebf3590006ba1194fa67acb2bc0511aed91648af977f15d5f5bb4e4229355104bd068288b2a"} build_url:https://queue.taskcluster.net/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/LS69Bn7KTcmuFSpPNKEJqg/artifacts/public/build/firefox-47.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/ba67964c651b853d73b1c5c4cf42120fc1610845b581ea02d17ffabed93d102fddc321d021c7ce1a55527d803cdbd5601a3a6dbf9f3994de68b9ce7c7024caa0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dbef93ba46f1024b9d3d35ecaf0a5a05e282173c57cf713980a9cebf3590006ba1194fa67acb2bc0511aed91648af977f15d5f5bb4e4229355104bd068288b2a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 09:37:33.339094) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:37:33.339651) ========= 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=652eb03db935cfc1c15ebda0000001ad-1456245573.653902-44278515 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:37:33.425933) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 09:37:33.426419) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 09:37:33.426932) ========= ========= Total master_lag: 0.32 =========