builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1464893617.35 results: success (0) buildid: 20160601061753 builduid: 0096620e028e41ca850770a1362868eb revision: 111970c73823 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:37.347680) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:37.348163) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:37.348457) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:37.362983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:37.363362) ========= 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=7de08804244eb36560b44971000001c3-1464893616.234957-1685311867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 11:53:37-- 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% 214M=0s 2016-06-02 11:53:37 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122192 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:37.499272) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:37.499629) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=7de08804244eb36560b44971000001c3-1464893616.234957-1685311867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020346 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:37.549609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:37.549986) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 111970c73823 --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 111970c73823 --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=7de08804244eb36560b44971000001c3-1464893616.234957-1685311867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 11:53:37,660 Setting DEBUG logging. 2016-06-02 11:53:37,661 attempt 1/10 2016-06-02 11:53:37,661 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/111970c73823?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 11:53:37,953 unpacking tar archive at: mozilla-central-111970c73823/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619033 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:38.182739) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:38.183067) ========= script_repo_revision: 111970c73823 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:38.183497) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:38.183776) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:38.192137) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-02 11:53:38.192453) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=7de08804244eb36560b44971000001c3-1464893616.234957-1685311867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:53:38 INFO - MultiFileLogger online at 20160602 11:53:38 in /builds/slave/test 11:53:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:53:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:53:38 INFO - {'append_to_log': False, 11:53:38 INFO - 'base_work_dir': '/builds/slave/test', 11:53:38 INFO - 'blob_upload_branch': 'Firefox', 11:53:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:53:38 INFO - 'branch': 'Firefox', 11:53:38 INFO - 'buildbot_json_path': 'buildprops.json', 11:53:38 INFO - 'config_files': ('talos/linux_config.py',), 11:53:38 INFO - 'default_actions': ('clobber', 11:53:38 INFO - 'read-buildbot-config', 11:53:38 INFO - 'download-and-extract', 11:53:38 INFO - 'populate-webroot', 11:53:38 INFO - 'create-virtualenv', 11:53:38 INFO - 'install', 11:53:38 INFO - 'run-tests'), 11:53:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:53:38 INFO - 'download_minidump_stackwalk': True, 11:53:38 INFO - 'download_symbols': 'ondemand', 11:53:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:53:38 INFO - 'tooltool.py': '/tools/tooltool.py', 11:53:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:53:38 INFO - '/tools/misc-python/virtualenv.py')}, 11:53:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:53:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:53:38 INFO - 'installer_path': 'installer.exe', 11:53:38 INFO - 'log_level': 'info', 11:53:38 INFO - 'log_name': 'talos', 11:53:38 INFO - 'log_to_console': True, 11:53:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:53:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:53:38 INFO - 'opt_config_files': (), 11:53:38 INFO - 'pip_index': False, 11:53:38 INFO - 'sps_profile': False, 11:53:38 INFO - 'sps_profile_interval': 0, 11:53:38 INFO - 'suite': 'dromaeojs-e10s', 11:53:38 INFO - 'system_bits': '32', 11:53:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:53:38 INFO - 'title': 'talos-linux64-ix-003', 11:53:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:53:38 INFO - 'use_talos_json': True, 11:53:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:53:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:53:38 INFO - 'work_dir': 'build'} 11:53:38 INFO - ##### 11:53:38 INFO - ##### Running clobber step. 11:53:38 INFO - ##### 11:53:38 INFO - Running pre-action listener: _resource_record_pre_action 11:53:38 INFO - Running main action method: clobber 11:53:38 INFO - rmtree: /builds/slave/test/build 11:53:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:53:39 INFO - Running post-action listener: _resource_record_post_action 11:53:39 INFO - ##### 11:53:39 INFO - ##### Finished clobber step (success) 11:53:39 INFO - ##### 11:53:39 INFO - ##### 11:53:39 INFO - ##### Running read-buildbot-config step. 11:53:39 INFO - ##### 11:53:39 INFO - Running pre-action listener: _resource_record_pre_action 11:53:39 INFO - Running main action method: read_buildbot_config 11:53:39 INFO - Using buildbot properties: 11:53:39 INFO - { 11:53:39 INFO - "project": "", 11:53:39 INFO - "product": "firefox", 11:53:39 INFO - "script_repo_revision": "production", 11:53:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:53:39 INFO - "repository": "", 11:53:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:53:39 INFO - "buildid": "20160601061753", 11:53:39 INFO - "stage_platform": "linux64-pgo", 11:53:39 INFO - "basedir": "/builds/slave/test", 11:53:39 INFO - "nightly_build": "True", 11:53:39 INFO - "buildnumber": 234, 11:53:39 INFO - "slavename": "talos-linux64-ix-003", 11:53:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:53:39 INFO - "platform": "ubuntu64_hw", 11:53:39 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 11:53:39 INFO - "branch": "mozilla-central", 11:53:39 INFO - "repo_path": "mozilla-central", 11:53:39 INFO - "revision": "111970c73823", 11:53:39 INFO - "pgo_build": "True", 11:53:39 INFO - "builduid": "0096620e028e41ca850770a1362868eb", 11:53:39 INFO - "slavebuilddir": "test" 11:53:39 INFO - } 11:53:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:53:39 INFO - Running post-action listener: _resource_record_post_action 11:53:39 INFO - ##### 11:53:39 INFO - ##### Finished read-buildbot-config step (success) 11:53:39 INFO - ##### 11:53:39 INFO - ##### 11:53:39 INFO - ##### Running download-and-extract step. 11:53:39 INFO - ##### 11:53:39 INFO - Running pre-action listener: _resource_record_pre_action 11:53:39 INFO - Running main action method: download_and_extract 11:53:39 INFO - mkdir: /builds/slave/test/build/tests 11:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:39 INFO - https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:53:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:53:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:53:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:53:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:53:40 INFO - Downloaded 1361 bytes. 11:53:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:53:40 INFO - Using the following test package requirements: 11:53:40 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:53:40 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:53:40 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:53:40 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:40 INFO - u'jsshell-linux-x86_64.zip'], 11:53:40 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:53:40 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:53:40 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:53:40 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:53:40 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:53:40 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:40 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:53:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:53:40 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')]} 11:53:40 INFO - https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:53:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:53:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:53:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:53:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:53:41 INFO - Downloaded 24422301 bytes. 11:53:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:53:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:53:43 INFO - Return code: 0 11:53:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:53:43 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')]} 11:53:43 INFO - https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:53:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:53:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:53:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:53:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:53:45 INFO - Downloaded 24422301 bytes. 11:53:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:53:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:53:46 INFO - Return code: 0 11:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:46 INFO - https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:53:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:53:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:53:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:53:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:53:47 INFO - Downloaded 10834055 bytes. 11:53:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:53:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:53:47 INFO - Return code: 0 11:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:47 INFO - https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:53:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:53:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:53:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:53:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:53:50 INFO - Downloaded 59024865 bytes. 11:53:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:53:50 INFO - mkdir: /builds/slave/test/properties 11:53:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:53:50 INFO - Writing to file /builds/slave/test/properties/build_url 11:53:50 INFO - Contents: 11:53:50 INFO - build_url:https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:53:50 INFO - Running post-action listener: _resource_record_post_action 11:53:50 INFO - Running post-action listener: set_extra_try_arguments 11:53:50 INFO - ##### 11:53:50 INFO - ##### Finished download-and-extract step (success) 11:53:50 INFO - ##### 11:53:50 INFO - ##### 11:53:50 INFO - ##### Running populate-webroot step. 11:53:50 INFO - ##### 11:53:50 INFO - Running pre-action listener: _resource_record_pre_action 11:53:50 INFO - Running main action method: populate_webroot 11:53:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:53:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:53:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:53:51 INFO - '--tppagecycles', 11:53:51 INFO - '7'], 11:53:51 INFO - 'tests': ['tsvgm']}}, 11:53:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:53:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:53:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:53:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:53:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:53:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:53:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:51 INFO - 'talos_options': ['--disable-e10s'], 11:53:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:53:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:53:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:51 INFO - 'talos_options': ['--disable-e10s'], 11:53:51 INFO - 'tests': ['damp', 'tps']}, 11:53:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:51 INFO - 'tests': ['damp', 'tps']}, 11:53:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:53:51 INFO - 'tests': ['dromaeo_dom']}, 11:53:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:53:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:53:51 INFO - 'tests': ['a11yr', 11:53:51 INFO - 'ts_paint', 11:53:51 INFO - 'tpaint', 11:53:51 INFO - 'sessionrestore', 11:53:51 INFO - 'sessionrestore_no_auto_restore', 11:53:51 INFO - 'tabpaint']}, 11:53:51 INFO - 'other-e10s': {'tests': ['a11yr', 11:53:51 INFO - 'ts_paint', 11:53:51 INFO - 'tpaint', 11:53:51 INFO - 'sessionrestore', 11:53:51 INFO - 'sessionrestore_no_auto_restore', 11:53:51 INFO - 'tabpaint']}, 11:53:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:53:51 INFO - 'ts_paint', 11:53:51 INFO - 'tpaint', 11:53:51 INFO - 'sessionrestore', 11:53:51 INFO - 'sessionrestore_no_auto_restore', 11:53:51 INFO - 'tabpaint']}, 11:53:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:53:51 INFO - 'ts_paint', 11:53:51 INFO - 'tpaint', 11:53:51 INFO - 'sessionrestore', 11:53:51 INFO - 'sessionrestore_no_auto_restore', 11:53:51 INFO - 'tabpaint']}, 11:53:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:53:51 INFO - 'tests': ['a11yr', 11:53:51 INFO - 'ts_paint', 11:53:51 INFO - 'tpaint', 11:53:51 INFO - 'sessionrestore', 11:53:51 INFO - 'sessionrestore_no_auto_restore', 11:53:51 INFO - 'tabpaint']}, 11:53:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:53:51 INFO - 'tests': ['a11yr', 11:53:51 INFO - 'ts_paint', 11:53:51 INFO - 'tpaint', 11:53:51 INFO - 'sessionrestore', 11:53:51 INFO - 'sessionrestore_no_auto_restore', 11:53:51 INFO - 'tabpaint']}, 11:53:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:53:51 INFO - 'tests': ['tsvgx', 11:53:51 INFO - 'tsvgr_opacity', 11:53:51 INFO - 'tart', 11:53:51 INFO - 'tscrollx', 11:53:51 INFO - 'cart']}, 11:53:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:53:51 INFO - 'tsvgr_opacity', 11:53:51 INFO - 'tart', 11:53:51 INFO - 'tscrollx', 11:53:51 INFO - 'cart']}, 11:53:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:51 INFO - 'talos_options': ['--disable-e10s'], 11:53:51 INFO - 'tests': ['tp5o']}, 11:53:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:51 INFO - 'tests': ['tp5o']}, 11:53:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:51 INFO - 'talos_options': ['--disable-e10s', 11:53:51 INFO - '--xperf_path', 11:53:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:53:51 INFO - 'tests': ['tp5n']}, 11:53:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:51 INFO - 'talos_options': ['--xperf_path', 11:53:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:53:51 INFO - 'tests': ['tp5n']}}, 11:53:51 INFO - 'talos.zip': {'path': '', 11:53:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:53:51 INFO - Running post-action listener: _resource_record_post_action 11:53:51 INFO - ##### 11:53:51 INFO - ##### Finished populate-webroot step (success) 11:53:51 INFO - ##### 11:53:51 INFO - ##### 11:53:51 INFO - ##### Running create-virtualenv step. 11:53:51 INFO - ##### 11:53:51 INFO - Running pre-action listener: _resource_record_pre_action 11:53:51 INFO - Running main action method: create_virtualenv 11:53:51 INFO - Creating virtualenv /builds/slave/test/build/venv 11:53:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:53:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:53:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:53:51 INFO - Using real prefix '/usr' 11:53:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:53:51 INFO - Installing distribute.............................................................................................................................................................................................done. 11:53:53 INFO - Installing pip.................done. 11:53:53 INFO - Return code: 0 11:53:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde90870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1746770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d59c0>, '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 0x17d68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6d50>, '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': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', '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 11:53:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:53:53 INFO - Using env: {'DISPLAY': ':0', 11:53:53 INFO - 'HOME': '/home/cltbld', 11:53:53 INFO - 'LANG': 'en_US.UTF-8', 11:53:53 INFO - 'LANGUAGE': 'en_US:en', 11:53:53 INFO - 'LOGNAME': 'cltbld', 11:53:53 INFO - 'MAIL': '/var/mail/cltbld', 11:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:53 INFO - 'MOZ_NO_REMOTE': '1', 11:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:53 INFO - 'NO_EM_RESTART': '1', 11:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:53 INFO - 'PWD': '/builds/slave/test', 11:53:53 INFO - 'SHELL': '/bin/bash', 11:53:53 INFO - 'SHLVL': '1', 11:53:53 INFO - 'TERM': 'linux', 11:53:53 INFO - 'TMOUT': '86400', 11:53:53 INFO - 'USER': 'cltbld', 11:53:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', 11:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:53 INFO - '_': '/tools/buildbot/bin/python'} 11:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:53 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 11:53:53 INFO - Cleaning up... 11:53:53 INFO - Return code: 0 11:53:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde90870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1746770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d59c0>, '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 0x17d68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6d50>, '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': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', '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 11:53:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:53:53 INFO - Using env: {'DISPLAY': ':0', 11:53:53 INFO - 'HOME': '/home/cltbld', 11:53:53 INFO - 'LANG': 'en_US.UTF-8', 11:53:53 INFO - 'LANGUAGE': 'en_US:en', 11:53:53 INFO - 'LOGNAME': 'cltbld', 11:53:53 INFO - 'MAIL': '/var/mail/cltbld', 11:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:53 INFO - 'MOZ_NO_REMOTE': '1', 11:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:53 INFO - 'NO_EM_RESTART': '1', 11:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:53 INFO - 'PWD': '/builds/slave/test', 11:53:53 INFO - 'SHELL': '/bin/bash', 11:53:53 INFO - 'SHLVL': '1', 11:53:53 INFO - 'TERM': 'linux', 11:53:53 INFO - 'TMOUT': '86400', 11:53:53 INFO - 'USER': 'cltbld', 11:53:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', 11:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:53 INFO - '_': '/tools/buildbot/bin/python'} 11:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:54 INFO - Downloading/unpacking psutil>=3.1.1 11:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:53:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:53:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:53:56 INFO - Installing collected packages: psutil 11:53:56 INFO - Running setup.py install for psutil 11:53:56 INFO - building 'psutil._psutil_linux' extension 11:53:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:53:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:53:56 INFO - building 'psutil._psutil_posix' extension 11:53:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:53:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:53:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:53:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:53:56 INFO - Successfully installed psutil 11:53:56 INFO - Cleaning up... 11:53:56 INFO - Return code: 0 11:53:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde90870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1746770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d59c0>, '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 0x17d68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6d50>, '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': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', '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 11:53:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:53:56 INFO - Using env: {'DISPLAY': ':0', 11:53:56 INFO - 'HOME': '/home/cltbld', 11:53:56 INFO - 'LANG': 'en_US.UTF-8', 11:53:56 INFO - 'LANGUAGE': 'en_US:en', 11:53:56 INFO - 'LOGNAME': 'cltbld', 11:53:56 INFO - 'MAIL': '/var/mail/cltbld', 11:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:56 INFO - 'MOZ_NO_REMOTE': '1', 11:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:56 INFO - 'NO_EM_RESTART': '1', 11:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:56 INFO - 'PWD': '/builds/slave/test', 11:53:56 INFO - 'SHELL': '/bin/bash', 11:53:56 INFO - 'SHLVL': '1', 11:53:56 INFO - 'TERM': 'linux', 11:53:56 INFO - 'TMOUT': '86400', 11:53:56 INFO - 'USER': 'cltbld', 11:53:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', 11:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:56 INFO - '_': '/tools/buildbot/bin/python'} 11:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:53:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:53:58 INFO - Installing collected packages: mozsystemmonitor 11:53:58 INFO - Running setup.py install for mozsystemmonitor 11:53:58 INFO - Successfully installed mozsystemmonitor 11:53:58 INFO - Cleaning up... 11:53:58 INFO - Return code: 0 11:53:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:53:58 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')]} 11:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:58 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')]} 11:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:58 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 0x7fde90870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1746770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d59c0>, '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 0x17d68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6d50>, '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': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', '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 11:53:58 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 11:53:58 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 11:53:58 INFO - Using env: {'DISPLAY': ':0', 11:53:58 INFO - 'HOME': '/home/cltbld', 11:53:58 INFO - 'LANG': 'en_US.UTF-8', 11:53:58 INFO - 'LANGUAGE': 'en_US:en', 11:53:58 INFO - 'LOGNAME': 'cltbld', 11:53:58 INFO - 'MAIL': '/var/mail/cltbld', 11:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:58 INFO - 'MOZ_NO_REMOTE': '1', 11:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:58 INFO - 'NO_EM_RESTART': '1', 11:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:58 INFO - 'PWD': '/builds/slave/test', 11:53:58 INFO - 'SHELL': '/bin/bash', 11:53:58 INFO - 'SHLVL': '1', 11:53:58 INFO - 'TERM': 'linux', 11:53:58 INFO - 'TMOUT': '86400', 11:53:58 INFO - 'USER': 'cltbld', 11:53:58 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', 11:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:58 INFO - '_': '/tools/buildbot/bin/python'} 11:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:59 INFO - Downloading/unpacking blobuploader==1.2.4 11:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:00 INFO - Downloading blobuploader-1.2.4.tar.gz 11:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:54:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:54:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:01 INFO - Downloading docopt-0.6.1.tar.gz 11:54:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:54:01 INFO - Installing collected packages: blobuploader, requests, docopt 11:54:01 INFO - Running setup.py install for blobuploader 11:54:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:54:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:54:01 INFO - Running setup.py install for requests 11:54:02 INFO - Running setup.py install for docopt 11:54:02 INFO - Successfully installed blobuploader requests docopt 11:54:02 INFO - Cleaning up... 11:54:02 INFO - Return code: 0 11:54:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54:02 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')]} 11:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:02 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')]} 11:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:02 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 0x7fde90870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1746770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d59c0>, '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 0x17d68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6d50>, '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': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', '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 11:54:02 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 11:54:02 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 11:54:02 INFO - Using env: {'DISPLAY': ':0', 11:54:02 INFO - 'HOME': '/home/cltbld', 11:54:02 INFO - 'LANG': 'en_US.UTF-8', 11:54:02 INFO - 'LANGUAGE': 'en_US:en', 11:54:02 INFO - 'LOGNAME': 'cltbld', 11:54:02 INFO - 'MAIL': '/var/mail/cltbld', 11:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:02 INFO - 'MOZ_NO_REMOTE': '1', 11:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:02 INFO - 'NO_EM_RESTART': '1', 11:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:02 INFO - 'PWD': '/builds/slave/test', 11:54:02 INFO - 'SHELL': '/bin/bash', 11:54:02 INFO - 'SHLVL': '1', 11:54:02 INFO - 'TERM': 'linux', 11:54:02 INFO - 'TMOUT': '86400', 11:54:02 INFO - 'USER': 'cltbld', 11:54:02 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', 11:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:02 INFO - '_': '/tools/buildbot/bin/python'} 11:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:54:02 INFO - Running setup.py (path:/tmp/pip-ztoErN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:54:02 INFO - Running setup.py (path:/tmp/pip-1SvC7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:54:02 INFO - Running setup.py (path:/tmp/pip-Or1maz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:54:02 INFO - Running setup.py (path:/tmp/pip-4NlOEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:54:02 INFO - Running setup.py (path:/tmp/pip-Rm3m6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:54:02 INFO - Running setup.py (path:/tmp/pip-1aOsYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:54:02 INFO - Running setup.py (path:/tmp/pip-QVMWcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:54:03 INFO - Running setup.py (path:/tmp/pip-NYQbIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:54:03 INFO - Running setup.py (path:/tmp/pip-nGNPKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:54:03 INFO - Running setup.py (path:/tmp/pip-kJyzeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:54:03 INFO - Running setup.py (path:/tmp/pip-SQsrNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:54:03 INFO - Running setup.py (path:/tmp/pip-Vje5_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:54:03 INFO - Running setup.py (path:/tmp/pip-q9Xbc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:54:03 INFO - Running setup.py (path:/tmp/pip-EkZ7jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:03 INFO - Running setup.py (path:/tmp/pip-K4RXc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:54:03 INFO - Running setup.py (path:/tmp/pip-ecg5Y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:54:03 INFO - Running setup.py (path:/tmp/pip-w_hPm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:54:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:54:03 INFO - Running setup.py install for manifestparser 11:54:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:54:03 INFO - Running setup.py install for mozcrash 11:54:03 INFO - Running setup.py install for mozdebug 11:54:04 INFO - Running setup.py install for mozdevice 11:54:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:54:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:54:04 INFO - Running setup.py install for mozfile 11:54:04 INFO - Running setup.py install for mozhttpd 11:54:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:54:04 INFO - Running setup.py install for mozinfo 11:54:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:54:04 INFO - Running setup.py install for mozInstall 11:54:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:54:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:54:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:54:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:54:04 INFO - Running setup.py install for mozleak 11:54:04 INFO - Running setup.py install for mozlog 11:54:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:54:04 INFO - Running setup.py install for moznetwork 11:54:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:54:04 INFO - Running setup.py install for mozprocess 11:54:04 INFO - Running setup.py install for mozprofile 11:54:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:54:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:54:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:54:05 INFO - Running setup.py install for mozrunner 11:54:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:54:05 INFO - Running setup.py install for mozscreenshot 11:54:05 INFO - Running setup.py install for moztest 11:54:05 INFO - Running setup.py install for mozversion 11:54:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:54:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:54:05 INFO - Cleaning up... 11:54:05 INFO - Return code: 0 11:54:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:05 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 0x7fde90870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1746770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d59c0>, '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 0x17d68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6d50>, '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': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', '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 11:54:05 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 11:54:05 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 11:54:05 INFO - Using env: {'DISPLAY': ':0', 11:54:05 INFO - 'HOME': '/home/cltbld', 11:54:05 INFO - 'LANG': 'en_US.UTF-8', 11:54:05 INFO - 'LANGUAGE': 'en_US:en', 11:54:05 INFO - 'LOGNAME': 'cltbld', 11:54:05 INFO - 'MAIL': '/var/mail/cltbld', 11:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:05 INFO - 'MOZ_NO_REMOTE': '1', 11:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:05 INFO - 'NO_EM_RESTART': '1', 11:54:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:05 INFO - 'PWD': '/builds/slave/test', 11:54:05 INFO - 'SHELL': '/bin/bash', 11:54:05 INFO - 'SHLVL': '1', 11:54:05 INFO - 'TERM': 'linux', 11:54:05 INFO - 'TMOUT': '86400', 11:54:05 INFO - 'USER': 'cltbld', 11:54:05 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', 11:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:05 INFO - '_': '/tools/buildbot/bin/python'} 11:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:54:05 INFO - Running setup.py (path:/tmp/pip-oP3yqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:54:05 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)) 11:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:54:05 INFO - Running setup.py (path:/tmp/pip-C0EtuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:54:05 INFO - Running setup.py (path:/tmp/pip-KVGTv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:54:05 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)) 11:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:54:05 INFO - Running setup.py (path:/tmp/pip-5Q2SBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:54:06 INFO - Running setup.py (path:/tmp/pip-TSBx5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:54:06 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)) 11:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:54:06 INFO - Running setup.py (path:/tmp/pip-nsekOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:54:06 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)) 11:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:54:06 INFO - Running setup.py (path:/tmp/pip-kW7PHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:54:06 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)) 11:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:54:06 INFO - Running setup.py (path:/tmp/pip-bvxDdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:54:06 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)) 11:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:54:06 INFO - Running setup.py (path:/tmp/pip-EN8mPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:54:06 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)) 11:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:54:06 INFO - Running setup.py (path:/tmp/pip-0W7lxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 11:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:54:06 INFO - Running setup.py (path:/tmp/pip-QPHzoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:54:06 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)) 11:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:54:06 INFO - Running setup.py (path:/tmp/pip-DHZAIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:54:06 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)) 11:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:54:06 INFO - Running setup.py (path:/tmp/pip-sA4qR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:54:06 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)) 11:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:54:06 INFO - Running setup.py (path:/tmp/pip-vAK_LR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:54:06 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)) 11:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:06 INFO - Running setup.py (path:/tmp/pip-R13Qqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:06 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)) 11:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:54:06 INFO - Running setup.py (path:/tmp/pip-3KvVeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:54:06 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)) 11:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:54:06 INFO - Running setup.py (path:/tmp/pip-qKG0df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:54:06 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)) 11:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:54:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:08 INFO - Downloading blessings-1.6.tar.gz 11:54:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:54:08 INFO - Installing collected packages: blessings 11:54:08 INFO - Running setup.py install for blessings 11:54:09 INFO - Successfully installed blessings 11:54:09 INFO - Cleaning up... 11:54:09 INFO - Return code: 0 11:54:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:54:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:54:09 INFO - Reading from file tmpfile_stdout 11:54:09 INFO - Current package versions: 11:54:09 INFO - argparse == 1.2.1 11:54:09 INFO - blessings == 1.6 11:54:09 INFO - blobuploader == 1.2.4 11:54:09 INFO - docopt == 0.6.1 11:54:09 INFO - manifestparser == 1.1 11:54:09 INFO - mozInstall == 1.12 11:54:09 INFO - mozcrash == 0.17 11:54:09 INFO - mozdebug == 0.1 11:54:09 INFO - mozdevice == 0.48 11:54:09 INFO - mozfile == 1.2 11:54:09 INFO - mozhttpd == 0.7 11:54:09 INFO - mozinfo == 0.9 11:54:09 INFO - mozleak == 0.1 11:54:09 INFO - mozlog == 3.2 11:54:09 INFO - moznetwork == 0.27 11:54:09 INFO - mozprocess == 0.22 11:54:09 INFO - mozprofile == 0.28 11:54:09 INFO - mozrunner == 6.11 11:54:09 INFO - mozscreenshot == 0.1 11:54:09 INFO - mozsystemmonitor == 0.3 11:54:09 INFO - moztest == 0.7 11:54:09 INFO - mozversion == 1.4 11:54:09 INFO - psutil == 3.1.1 11:54:09 INFO - requests == 1.2.3 11:54:09 INFO - wsgiref == 0.1.2 11:54:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54: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')]} 11:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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')]} 11:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:09 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 0x7fde90870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1746770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d59c0>, '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 0x17d68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6d50>, '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': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', '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 11:54:09 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 11:54:09 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 11:54:09 INFO - Using env: {'DISPLAY': ':0', 11:54:09 INFO - 'HOME': '/home/cltbld', 11:54:09 INFO - 'LANG': 'en_US.UTF-8', 11:54:09 INFO - 'LANGUAGE': 'en_US:en', 11:54:09 INFO - 'LOGNAME': 'cltbld', 11:54:09 INFO - 'MAIL': '/var/mail/cltbld', 11:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:09 INFO - 'MOZ_NO_REMOTE': '1', 11:54:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:09 INFO - 'NO_EM_RESTART': '1', 11:54:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:09 INFO - 'PWD': '/builds/slave/test', 11:54:09 INFO - 'SHELL': '/bin/bash', 11:54:09 INFO - 'SHLVL': '1', 11:54:09 INFO - 'TERM': 'linux', 11:54:09 INFO - 'TMOUT': '86400', 11:54:09 INFO - 'USER': 'cltbld', 11:54:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', 11:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:09 INFO - '_': '/tools/buildbot/bin/python'} 11:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:09 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)) 11:54:09 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)) 11:54:09 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)) 11:54:09 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)) 11:54:09 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)) 11:54:09 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)) 11:54:09 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)) 11:54:09 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)) 11:54:09 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)) 11:54:09 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)) 11:54:09 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)) 11:54:09 INFO - Cleaning up... 11:54:09 INFO - Return code: 0 11:54:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:54: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')]} 11:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54: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')]} 11:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:09 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 0x7fde90870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1746770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d59c0>, '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 0x17d68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6d50>, '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': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', '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 11:54:09 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 11:54:09 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 11:54:09 INFO - Using env: {'DISPLAY': ':0', 11:54:09 INFO - 'HOME': '/home/cltbld', 11:54:09 INFO - 'LANG': 'en_US.UTF-8', 11:54:09 INFO - 'LANGUAGE': 'en_US:en', 11:54:09 INFO - 'LOGNAME': 'cltbld', 11:54:09 INFO - 'MAIL': '/var/mail/cltbld', 11:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:09 INFO - 'MOZ_NO_REMOTE': '1', 11:54:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:09 INFO - 'NO_EM_RESTART': '1', 11:54:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:09 INFO - 'PWD': '/builds/slave/test', 11:54:09 INFO - 'SHELL': '/bin/bash', 11:54:09 INFO - 'SHLVL': '1', 11:54:09 INFO - 'TERM': 'linux', 11:54:09 INFO - 'TMOUT': '86400', 11:54:09 INFO - 'USER': 'cltbld', 11:54:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', 11:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:09 INFO - '_': '/tools/buildbot/bin/python'} 11:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:09 INFO - Downloading/unpacking jsonschema 11:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:54:11 INFO - Downloading/unpacking functools32 (from jsonschema) 11:54:11 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 11:54:11 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 11:54:11 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 11:54:11 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 11:54:11 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 11:54:11 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 11:54:11 INFO - Downloading functools32-3.2.3-2.tar.gz 11:54:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:54:11 INFO - warning: no files found matching '*.txt' 11:54:11 INFO - no previously-included directories found matching 'build' 11:54:11 INFO - no previously-included directories found matching 'dist' 11:54:11 INFO - no previously-included directories found matching '.git*' 11:54:11 INFO - Installing collected packages: jsonschema, functools32 11:54:11 INFO - Running setup.py install for functools32 11:54:12 INFO - warning: no files found matching '*.txt' 11:54:12 INFO - no previously-included directories found matching 'build' 11:54:12 INFO - no previously-included directories found matching 'dist' 11:54:12 INFO - no previously-included directories found matching '.git*' 11:54:12 INFO - Successfully installed jsonschema functools32 11:54:12 INFO - Cleaning up... 11:54:12 INFO - Return code: 0 11:54:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde90870f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1746770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d59c0>, '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 0x17d68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6d50>, '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': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', '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 11:54:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:54:12 INFO - Using env: {'DISPLAY': ':0', 11:54:12 INFO - 'HOME': '/home/cltbld', 11:54:12 INFO - 'LANG': 'en_US.UTF-8', 11:54:12 INFO - 'LANGUAGE': 'en_US:en', 11:54:12 INFO - 'LOGNAME': 'cltbld', 11:54:12 INFO - 'MAIL': '/var/mail/cltbld', 11:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:12 INFO - 'MOZ_NO_REMOTE': '1', 11:54:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:12 INFO - 'NO_EM_RESTART': '1', 11:54:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:12 INFO - 'PWD': '/builds/slave/test', 11:54:12 INFO - 'SHELL': '/bin/bash', 11:54:12 INFO - 'SHLVL': '1', 11:54:12 INFO - 'TERM': 'linux', 11:54:12 INFO - 'TMOUT': '86400', 11:54:12 INFO - 'USER': 'cltbld', 11:54:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', 11:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:12 INFO - '_': '/tools/buildbot/bin/python'} 11:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:12 INFO - Downloading/unpacking flake8 11:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:54:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:54:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:54:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:54:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:54:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:54:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:54:14 INFO - no previously-included directories found matching 'docs/_build' 11:54:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:54:15 INFO - Running setup.py install for pep8 11:54:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:54:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:54:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:54:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:54:15 INFO - no previously-included directories found matching 'docs/_build' 11:54:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:54:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:54:15 INFO - Cleaning up... 11:54:15 INFO - Return code: 0 11:54:15 INFO - Running post-action listener: _resource_record_post_action 11:54:15 INFO - Running post-action listener: _start_resource_monitoring 11:54:15 INFO - Starting resource monitoring. 11:54:15 INFO - ##### 11:54:15 INFO - ##### Finished create-virtualenv step (success) 11:54:15 INFO - ##### 11:54:15 INFO - ##### 11:54:15 INFO - ##### Running install step. 11:54:15 INFO - ##### 11:54:15 INFO - Running pre-action listener: _resource_record_pre_action 11:54:15 INFO - Running main action method: install 11:54:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:54:15 INFO - Reading from file tmpfile_stdout 11:54:15 INFO - Detecting whether we're running mozinstall >=1.0... 11:54:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:54:15 INFO - Reading from file tmpfile_stdout 11:54:15 INFO - Output received: 11:54:15 INFO - Usage: mozinstall [options] installer 11:54:15 INFO - Options: 11:54:15 INFO - -h, --help show this help message and exit 11:54:15 INFO - -d DEST, --destination=DEST 11:54:15 INFO - Directory to install application into. [default: 11:54:15 INFO - "/builds/slave/test"] 11:54:15 INFO - --app=APP Application being installed. [default: firefox] 11:54:15 INFO - mkdir: /builds/slave/test/build/application 11:54:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:54:32 INFO - Reading from file tmpfile_stdout 11:54:32 INFO - Output received: 11:54:32 INFO - /builds/slave/test/build/application/firefox/firefox 11:54:32 INFO - Running post-action listener: _resource_record_post_action 11:54:32 INFO - ##### 11:54:32 INFO - ##### Finished install step (success) 11:54:32 INFO - ##### 11:54:32 INFO - ##### 11:54:32 INFO - ##### Running run-tests step. 11:54:32 INFO - ##### 11:54:32 INFO - Running pre-action listener: _resource_record_pre_action 11:54:32 INFO - Running main action method: run_tests 11:54:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:54:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:54:32 INFO - Python 2.7.3 11:54:32 INFO - Return code: 0 11:54:32 INFO - grabbing minidump binary from tooltool 11:54:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d59c0>, '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 0x17d68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d6d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:54:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:54:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:54:32 INFO - Calling ['/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'] with output_timeout 600 11:54:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:54:32 INFO - Return code: 0 11:54:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:54:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:54:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:54:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:54:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:54:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:54:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:54:33 INFO - Return code: 0 11:54:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 11:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 11:54:33 INFO - Using env: {'DISPLAY': ':0', 11:54:33 INFO - 'HOME': '/home/cltbld', 11:54:33 INFO - 'LANG': 'en_US.UTF-8', 11:54:33 INFO - 'LANGUAGE': 'en_US:en', 11:54:33 INFO - 'LOGNAME': 'cltbld', 11:54:33 INFO - 'MAIL': '/var/mail/cltbld', 11:54:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:54:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:33 INFO - 'MOZ_NO_REMOTE': '1', 11:54:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:33 INFO - 'NO_EM_RESTART': '1', 11:54:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:33 INFO - 'PWD': '/builds/slave/test', 11:54:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:54:33 INFO - 'SHELL': '/bin/bash', 11:54:33 INFO - 'SHLVL': '1', 11:54:33 INFO - 'TERM': 'linux', 11:54:33 INFO - 'TMOUT': '86400', 11:54:33 INFO - 'USER': 'cltbld', 11:54:33 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464893616.234957-1685311867', 11:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:33 INFO - '_': '/tools/buildbot/bin/python'} 11:54:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 11:54:33 INFO - mozversion application_buildid: 20160601061753 11:54:33 INFO - mozversion application_changeset: 111970c738234569c8c180319155327316335deb 11:54:33 INFO - mozversion application_display_name: Nightly 11:54:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:54:33 INFO - mozversion application_name: Firefox 11:54:33 INFO - mozversion application_remotingname: firefox 11:54:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:54:33 INFO - mozversion application_vendor: Mozilla 11:54:33 INFO - mozversion application_version: 49.0a1 11:54:33 INFO - mozversion platform_buildid: 20160601061753 11:54:33 INFO - mozversion platform_changeset: 111970c738234569c8c180319155327316335deb 11:54:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:54:33 INFO - mozversion platform_version: 49.0a1 11:54:33 INFO - using testdate: 1464893673 11:54:33 INFO - actual date: 1464893673 11:54:33 INFO - starting webserver on 'localhost:49264' 11:54:33 INFO - SUITE-START | Running 2 tests 11:54:33 INFO - TEST-START | dromaeo_css 11:54:33 INFO - operating with platform_type : linux_ 11:54:33 INFO - Initialising browser for dromaeo_css test... 11:54:33 INFO - TEST-INFO | started process 26557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpawXpoK/profile http://localhost:49264/getInfo.html) 11:54:38 INFO - PROCESS | 26557 | __metrics Screen width/height:1600/1200 11:54:38 INFO - PROCESS | 26557 | colorDepth:24 11:54:38 INFO - PROCESS | 26557 | Browser inner width/height: 1024/697 11:54:38 INFO - PROCESS | 26557 | __metrics 11:54:39 ERROR - PROCESS | 26557 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 11:54:40 INFO - TEST-INFO | 26557: exit 0 11:54:40 INFO - Browser initialized. 11:54:40 INFO - Running cycle 1/1 for dromaeo_css test... 11:54:40 INFO - TEST-INFO | started process 26677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpawXpoK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:54:51 INFO - PROCESS | 26677 | RSS: Main: 167002112 11:54:51 INFO - PROCESS | 26677 | 11:55:41 INFO - PROCESS | 26677 | 1464893741421 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] 11:57:48 INFO - PROCESS | 26677 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 11:57:49 INFO - PROCESS | 26677 | RSS: Main: 171008000 11:57:49 INFO - PROCESS | 26677 | 12:00:51 INFO - PROCESS | 26677 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 12:00:52 INFO - PROCESS | 26677 | RSS: Main: 169844736 12:00:52 INFO - PROCESS | 26677 | 12:03:54 INFO - PROCESS | 26677 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 12:03:54 INFO - PROCESS | 26677 | RSS: Main: 171737088 12:03:54 INFO - PROCESS | 26677 | 12:06:56 INFO - PROCESS | 26677 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 12:06:57 INFO - PROCESS | 26677 | RSS: Main: 168747008 12:06:57 INFO - PROCESS | 26677 | 12:09:59 INFO - PROCESS | 26677 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 12:10:00 INFO - PROCESS | 26677 | RSS: Main: 170610688 12:10:00 INFO - PROCESS | 26677 | 12:13:02 INFO - PROCESS | 26677 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 12:13:03 INFO - PROCESS | 26677 | RSS: Main: 171855872 12:13:03 INFO - PROCESS | 26677 | 12:13:03 INFO - PROCESS | 26677 | __start_tp_report 12:13:03 INFO - PROCESS | 26677 | _x_x_mozilla_page_load 12:13:03 INFO - PROCESS | 26677 | _x_x_mozilla_page_load_details 12:13:03 INFO - PROCESS | 26677 | |i|pagename|runs| 12:13:03 INFO - PROCESS | 26677 | |0;dojo.html;3138.623365196177;3158.447271727448;3186.792858464201;3197.6962188592083;3212.2130078130863;5387.245785590016;5425.213344065108;5432.701201433914;5452.127659574468;5513.283273174482;5373.704446255454;5456.8090116845915;5487.42382049885;5505.697186654733;5529.087700529418;4981.775820088104;4985.102681517325;5083.872903177413;5128.794848206067;5177.715225662587;766.5611580061474;5002.374703162105;5009.899802003958;5042.520960508746;5106.846794596168;5013.749312534395;5046.470120637336;5066.544011039005;5068.06240845443;5092.84721458355;4974.651774375795;5055.646104772667;5081.517255860687;5085.313482679828;5086.643934924557;4980.352554167971;4984.053029924303;4993.400791904958;5020.799168033274;5042.647014708972;5356.464353564651;5362.329708786402;5390.51485366319;5402.9729851350885;5445.9652665993335;5684.971575142098;5766.740496677618;5787.50806181475;5896.233489646362;5903.380145084747;5885.4997325227405;5920.721528764009;5938.643681379088;5951.2858456985;5991.730372133265;5541.445855414467;5551.278333816578;5565.0817615093465;5567.721613919288;5569.053260945609;5826.941730582725;5985.371535988658;6026.246719160105;6056.121862329937;6067.514598832083;5813.680247586423;5815.098659707752;5839.065749480063;5844.0941654042845;5874.089516125007;5883.17635531026;5917.437843404869;5922.3485416605;5950.821475355746;5951.5238780897425;5659.745311460994;5809.8547536311935;5814.709264536757;5864.501517370986;5888.558358123072;5715.228444160069;5795.710214489259;5798.768049278066;5835.212246346774;5930.673812940329;4456.108778244364;4465.173942820524;4470.754108523997;4473.373727678128;4514.932276015862;3895.2793733159456;3923.588023257517;3944.073142811437;4005.0788318686864;4008.2985477541315;5604.243427137284;5648.971755141198;5653.660780353192;5656;5700.657960522382;5757.88484230313;5909.911351329733;5975.731092100866;5980.85047873798;6009.459148676553;5526.751296191681;5574.860628484239;5584.385717571064;5585.218069470277;5625.38120806711;5075.670081444694;5091.5672167865405;5096.311997880312;5102.979404119191;5147;5934.970325148347;5975.7609695612555;6138.202033735675;6164.198654175018;6168.660723660152;5836.095405212199;5949.167116603766;5956.731947062306;5958.225430694156;5985.610935289105;6056.121862330026;6069.211002569814;6086.360932102242;6097.512199024156;6102.115193297036;5658.349289831722;5700.2304688868135;5717.371089180104;5819.82540523785;5829.446202610745;5878.29460464747;5887.58786884931;5935.762569497172;5936.525077993837;5974.671393073423;5705.144228365612;5722.484976352148;5727.8854422912145;5750.769969201185;5756.740946657326;5474.288342515448;5666.433356664301;5747.712614369349;5771.451712087345;5787.56593255516;5493.890122197614;5558.388577256418;5613.270274864241;5615.578831587729;5647.3505546861;5825.94174058271;5832.562557808096;5850;5863.413658634273;5867.471927526543;5515.145152501369;5608.803691870765;5655.802046928337;5658.321001479849;5724.169995350734 12:13:03 INFO - PROCESS | 26677 | |1;ext.html;587.6503480429146;618.7030225491761;626.0484064222383;645.825627080688;651.8500744828692;33403.16492087696;37037;43806;45206.773966130204;45245.7737711311;46489;46547.534524654744;46745.76627116868;47118.52881471184;47182.292265616044;8682.175193356637;8807.64769409226;8817.118288171196;8820.470771753684;8831.77920551985;8754.255888249507;8783.692570760024;8834.204921557091;8847.95576022119;8859.335549833757;8819.603117859711;8859.025507194203;8896.021437641853;8909.821803563926;8912.331575131859;8776.341774366916;8786.472811631258;8847.823043539092;8874.42316249445;8886.777830554223;8758.12418758119;8902.73291801247;8913.376063675545;8915.866262006075;8924.152205540464;43198.56801431977;43610;43687.12625747499;43692.3446148308;43696;3405.540252065964;3461.273132642123;3555.7333200010103;3562.839672214757;3977.9657289104753;32861;32945.01164965055;33157.35898766513;33321;34219.82890085533;4246.6602671786495;4308.253334064001;4309.41822853917;4377.190219809346;4540.341650460698;251671;251864;252226.99999999817;252867;253397;58844;59239.40760592425;59374.70312648409;59387.70306148528;59555;36225.45661815075;37282;37415.812920935765;65902;66196.66901665558;17623;18081.547961301072;18125.818741812676;18136.365227216986;18228.726569101473;12810.359482025862;12828.10203285761;12847.935760321325;12915.806262906064;12925.935370323088;19478.513037174183;19529.511762206057;19532.12105455258;19546.218151274075;19580.804191957897;7391.852162956819;7441.441891858132;7579.242075792376;7634.770182425056;7746.147923728386;1031.2162756305263;1079.5304042741432;1158.965231043053;1209.5403746576244;1253.924764514132;32936.835315823264;32962.83518582392;33165.336693266;33563.16092097717;33620.1171584613;1076.7523469602036;1095.7315457712912;1101.9944900275448;1166.976660466786;1216.3492531495608;17022.017317438273;17424.47726568205;17557.122143892753;17645.7353139703;17851.107444627716;622444;622566;626394;626637;631252;60863.39136608666;60888.39111608827;61954.380456194864;61974.69012654908;62142;1330.6274243211917;1362.768329384007;1370.4244217428504;1374.2579007335926;1396.427464739452;30050.398992020473;31230;31608.683913161494;32103;32491.675083248865;52818.47181528136;53312.73343633257;53652.46347536475;53666.195007074144;53699.73150134224;457879;458045;463824;465598;466483;28191;28466.857665711537;28738.425231495672;28739.28151796222;28741.856290718413;48649.513504864495;49742.50257497379;50034.49965500298;50576.74711626418;51172.232416514526;41966.79016604897;43173.3523997134;43227.56772432361;43725.78137109294;44216;41276.58723412728;41618;42407.78796106;42583.3612495819;42894.14211715811;41675.7916210417;41762.791186043876;42327.788361057996;42378;42988;35456.46815297824;37140.517605022425;37159.81420092882;37808.62191378051;38144.237115258096;27561;28745.568816467352;28773.712262877103;28791.280217994718;28859.42281154323 12:13:03 INFO - PROCESS | 26677 | |2;jquery.html;390.39293897988625;396.62122672847397;396.9980150099249;397.29876767505357;412.0276148290035;18146.81853181468;19526.609467810635;19949.900250498762;19951.10220040098;20205.292814751487;18638.440846774585;19155.329563465246;19378.612427751435;20294.69557956632;20317.0857311421;6348.936510634892;6381.298057213703;6587.473002159816;6592.934070659304;6599.604023758566;6458.418742313191;6460.644664543448;6496.285408605049;6542.607443553402;6560.147180866505;6714.194296684404;6838.9658051709675;6956.965215173917;6959.721611135548;6968.44252459802;6984.4412447004115;7172.103487064117;7209.675564599579;7233.276672332751;7243.275672432767;7025.543339682956;7063.964680176618;7088.113985751781;7104.644767761643;7118.39493643041;24954;25562.616560751605;26243.868780655976;26508.469830603473;26687.733122668913;2198.3844523533435;2271.65925111233;2286.67986481891;2371.6916800815957;2422.1401402502033;15133.319000644888;15613.453529126426;15695.450659226986;15960.600984975352;16231.59421014484;1863.1522657190947;1901.8288354048202;1990.2138655231104;2004.3485867093252;2069.0031933966725;93751;96862.51568742182;97565;98898;99795.50102249443;17260.91369543144;18013.819861801214;18167.818321816878;18483.445496635122;18520.16659250337;31934.520982185284;32591.511127332633;32641.347173056405;32663.346733065682;32758.344833103205;9841.50792460374;9875.802483950425;9906.05892440217;10151;10213.693589192337;8201.630926608317;8295.502269863828;8341.249287564027;8443.704470343508;8510.404271700922;8678.479291242546;8839.116088391109;8918.687845925362;8951.955240223757;9077.23144440952;3432.7253819694365;3487.755857089979;3659.7255205859665;3700.444933259979;3704.68510176638;910.8770316007254;971.946542940145;1001.439194051319;1072.9248952573246;1076.2573824061528;18771.530711732044;19168.329108481135;19570.90214548918;19683.507912302022;19817.702734458995;952.3904700991371;991.2664628175243;1003.0070230471927;1010.6210171185805;1024.446798728693;9120.589573469077;10656.680299591024;10665.893341066645;10724.463776811284;10763.461826908624;454849;459738;460036;466877;513675;92578.53710731538;94487.52756236175;97239;97582.51208743911;97904.51047744715;941.8257622339889;964.1997142371814;994.8159590475785;1017.1557607186018;1025.958961641541;16476.588085297964;16963.915180424512;17005.82994170092;17040.914795425942;17370.305187792852;41583.168336632494;42676.35985460283;42713.786431067645;44011.11977760491;44065.77967110144;58362;59602.40397596142;59857.40142598518;59963.40036599578;60444;7422.406207503279;7750.689972401041;7833.334166595903;7870.370370370471;7933.801654958442;9548.52257387114;12183.512659493521;12610.936945315214;13548.525801596898;13839.308034598029;11690.18168728215;12076.154669173073;12170.75658486843;12293.877061229274;12489.750204996031;5550.195221692751;10878;11467.885321146681;11539.134564907834;11589.768204636028;10994.395308258123;11987.700307492383;12306.323152226714;12390.256584604953;12410.441530130985;8607.698730544402;8742.125787421208;8749.650013999624;8959.686410975584;8986;11316.321020738782;12003.879961200626;12018.699532511757;12019.75960480803;12136.150469467053 12:13:03 INFO - PROCESS | 26677 | |3;mootools.html;1481.081729327817;1494.4993427201887;1665.3671604790177;1789.1143883777524;1807.8282563156513;7628.618569071552;8140;8253.752387428372;8750.387472876893;8830.867536986942;8023.117457079717;8270.586470676471;8342.708005219818;8343;8343.582820858963;2299.735530414003;2313.571989181998;2322.837401381904;2338.96491552626;2345.5660702769956;2306.9192578259763;2309.722833260011;2346.495503466754;2350.8119350452007;2359.1035406545575;2327.8603283803027;2328.7671232876746;2329.7087864017;2367.6803631509697;2375.5961486547244;2296.115995341797;2323.4191452136965;2337.345543247885;2342.1685301717816;2343.2970108967243;2230.631945728953;2234.0393630738777;2251.79733823955;2258.7741225877444;2260.242818655752;8428.157184281585;8478.364122690762;8494.06565277819;8501.787455313604;8522.40343175978;5072.112380333427;5232.6860388376435;5268.789248430058;5277.419483856773;5302.045631786277;3218.7103160715646;3405.9836736323255;3450.3271861986923;3460.9653903460894;3478.2000139967695;1156.468024708635;1156.9537218511334;1207.3480320626852;1236.0729452910318;1246.731952630189;11771.23486973344;11787.94106029473;11823.467943942544;11842.644720658394;11849.585264515701;4608.446986361658;4629.166749984967;4723.173444647173;4742.9762851186215;4750.95249047512;9991.800163996679;10032.548535315927;10066.446345450924;10082.69751907444;10099.94950025245;5112.079825631347;5181.041507321158;5199.844004679866;5264.9736751315995;5280.471952804689;4218.978905105455;4710.905781884343;4784.712917224978;4845.9030819383415;4855.32025516428;3960.7623542587535;3984.7609143451486;4046.838126474967;4099;4108.876733697994;1296.9610911672664;1301.1932601786953;1305.6017914536158;1305.6670549009941;1305.8106574546637;928.1182876267438;940.1350757303297;957.8467445208734;960.0735290444754;988.5353883674661;5483.835484935458;5540.889182216333;5589.860253493695;5693.231413759172;5809.622374545641;463.25647336025196;465.2509459769768;473.1554175796256;474.11814025911775;474.80532981477427;3685.90785230366;3724.906877328034;3730.4963829882618;3737.7944213068;3848.134169811826;10362.067413932782;10623.893761062445;10688.198385120992;10708.946455267675;10731.624393146358;10293.228007899437;10506.317089389166;10507.527161277761;10549.20880933933;10562.894371056345;7801.960990195126;7849.175836537195;7931.762047138595;7964.402669799672;7983.760487185394;5555.8888822224135;5616.1856530803625;5646.209530665792;5677.716114194356;5720.256366672306;9725.319227653996;9801;9807.509624518889;9813.754656133653;9815.55829987638;9701.563429645541;9909.752256193364;9928.702138935843;9959.452230127412;9994.600215991279;6717.664116794239;7122.679479423335;7244.891326630211;7418.740344087931;7561.924380756122;8216.589170541329;8243.422960392954;8251.216134467217;8277.130901255281;8316.5425901576;7310.342069213796;7560.395168386626;7561.281678240558;7581.9926433722985;7713.498622589514;7383.07711536058;7404.370628496638;7499.362554182955;7531.510451820614;7551.244875512405;6681.599104053772;6698.56459330142;6712.563683360566;6718.865622687421;6742.460603151834;4722.834700785456;4866.8053277868485;4881.438634557071;4906.975465122651;4925.901481970269;4808.182608956416;4934.111859865258;4948.331975183304;5000.574951129195;5164.070467315919 12:13:03 INFO - PROCESS | 26677 | |4;prototype.html;324.7418302449554;330.40856866209486;336.29042719861087;337.9932401351973;339.123366098635;5459.808906688262;5657.632253903494;5675.404082571333;5730.598858079931;5732.939406209844;5569.498745112939;5590.692511911843;5610.915836262459;5619.2299425680885;5660.830175094754;4427.335899615051;4444;4454.688171827957;4472.3515090311885;4497.820087196525;4335.43639326887;4395.571588506033;4422.535633758457;4439.689221754478;4446.355278484618;4386.583274588925;4387.934180987288;4406.36107764374;4425.4910685271125;4442.289233722605;4396.164728701537;4433.379326894205;4438.933415998763;4443.888902777424;4483.7758112094425;3595.352836489431;3789.2232092420986;3826.9234615307814;3963.5243770747406;3976.741511801724;5494.066008778517;5494.2857428534435;5503.147012213073;5513.889722205574;5514;4933.235348520985;4945.208766597363;4997.675151115166;5000.799968001275;5008.398992120969;5801.7389217485315;5885.85285367865;5909.497692696083;5911.586188966774;5949.512621844538;4093.1813637272367;4173.290540608074;4179.328268692517;4185.748855068675;4193.203291374629;5830.941690583125;5950.899083669535;6084.60450070744;6114.419130182626;6115.908261376083;4204.474440694913;4207.821809893235;4219.43037689914;4234.767087810138;4235.385869048971;4281.602302710492;4296.763677997677;4300.354946757949;4306.763128027988;4335.6965012449455;4836.274558816206;4921.827736029221;4982.701037937735;5006.374203224597;5016.824411145592;5884.617499862496;5892.027815410409;5910.468057874812;5927.229460170151;5985.790497332572;1463.341496326636;1487.7842712806582;1491.4779827060659;1496.2369191712305;1499.3702644889172;912.4525284829182;934.2666007184328;955.9569819358146;956.0296299256122;963.7012526116927;5062.025809934129;5074.01056793929;5081.568066714297;5109.8722531936255;5125.820596279187;5334.51989320963;5353.699837161183;5378.767811358242;5381.735292206328;5464.153056276284;4917.690978772448;4979.560015592406;5051.974740126349;5094.2103973884105;5135.435102138762;2862.7566656833988;2879.5680647902564;2900.8984685535906;2904.390078083584;2917.7082291770653;5434.3207099112615;5457.045017121988;5498.285222920995;5501.559875209973;5526.364468086141;5423.264555342332;5830.387809279964;6274;6322.743786949724;6335.334789847092;6348.269948955837;6390.552661313756;6418.390252925965;6419.903701444482;6420.133282006869;5962.135490353788;6156.876862462636;6161.599496032743;6202.844928876814;6231.470325022424;6098.512119030378;6101.603395779438;6102.572819902742;6159.938400615936;6179.382061793965;6105.419985101408;6137.570370074231;6283.74865005413;6297.2128483939505;6315.494760419064;4275.87172384829;4290.914181716411;4319.11458151072;4327.350897365421;4330.069035157457;5800.9419905800405;6139.693015349126;6176.135341052166;6184.257889053342;6191.442770150708;5896.852578685567;5912.852178695395;5919.526437885045;6030.652987591929;6093.634381937098;5949.3455719871645;6014.729337179925;6018.458338749533;6033.9698301508215;6037.728302226323;5622.24099746529;5919.792807251725;5927.496162826208;5932.199153114274;5935.525157987265;6003.729832157476;6027.035674292092;6056.3035250946705;6080.574359794949;6080.90878636812;5628.634138780966;5911.704414779158;5916.467517923407;5922.230110085661;5931.792387266425 12:13:03 INFO - PROCESS | 26677 | |5;yui.html;726.3027493606138;806.612825843595;806.7821688144197;829.1584042197169;853.7566793463864;13970.580882573526;14789.556313310592;14871.182084985321;14935.402583896659;14977;13551.119177253471;13664.316784160777;13768.724625507484;13773.51792687256;13841.238731869744;819.9385046121535;831.8669012957928;836.9037560680539;838.656150978099;838.9706360277391;814.7067055859885;837.6398148796015;837.9371547133959;841.8400503904269;843.0641987394018;882.8057827277988;884.3323290915382;885.6014793342989;886.1935638568904;887.4763889305309;872.4242000279849;874.514644372373;878.064860923118;880.6037283222544;882.3294296334767;632.4371309534517;636.9076483909854;640.1965533255734;640.5132099604288;640.7308930249307;14560.199189044704;14646.97471177018;14708.338124784303;14720.926395368062;14733.410663573444;13717.931410342984;13741.793873091812;13776.793348099787;13860.168389896638;13905.304734763322;11739.647810565697;11808.822867656992;11848.105298791239;11985.880141198651;12089.879101208964;3741.1395379062697;3813.866514671973;3819.1597848473293;3845.3078445879732;3939.5666476687543;60933;61715.074273885926;61876.38123618751;62074.37925620686;62193.37806621921;10017.248706347053;10252.538635761259;10271.7432064199;10410.68767936963;10512.789744205073;19911.10400032002;19954.20183192685;20004.69992950107;20025.799742002684;20046.89976550137;8398.034226063959;8423.536705481258;8570.185832345916;8580.570971451403;8620.051794302623;4795.904081918342;4805.399325084364;4807.302941073594;4833.830815921426;4928.359313289321;3307.4377355849565;3452.482127680868;3465.8960231193105;3467.878624248139;3482.373172828915;576.6136688418769;589.0751520113381;594.9970250148808;602.1419477244908;607.9179310793074;649.76283656466;720.1933834105835;730.7332823519378;745.9552426854406;749.6655952404728;9189.3108016899;9517.333786635008;9619;9619.753676910083;9636.46999415039;650.3951325267547;730.2223132364015;748.3152915082638;751.6880494594682;767.0909971683573;4323.6757243206885;4491.752953587584;4589.472210695746;4627.236505976543;4634.351190833286;70203.2979670207;70715.2928470719;70876.64561677158;71386;71564.06397648179;46562.30156547655;48926.75536622294;59461.702691486265;64619;65537.01694474586;57259.713701431225;58079;58218;58731.706341468016;59090.70454647699;8928.86606700887;8942.418742781698;8977.23693486061;8988.86516702237;8997.378049388577;37827;37980.810095949346;38179.42730858984;38608;39096.21807563776;48330.275045875045;51902.221466678784;52022;52254.47745522496;52836;11337.388435008887;11388.14588905852;11459.598914037968;11751.588694395656;12049.879501204876;12974.096785962553;13072.934635326763;13077.542286019943;13153.802692959422;13476.191428514321;12135.393230338272;12228.327441990776;12235.32705701195;12990;13090.280034598189;12202.435530796005;12447.875521245034;12587.11890167716;12777.744445111231;12791;11817.586384476503;12392.690182745504;12427.31649759272;12445.315507646805;12641.2415255085;10112.49437528106;10182.49087545605;10351.011786742822;10580.84128738085;10585.629502967358;10209.642662506776;10324.277300588887;10369.896301036893;10477.637907072032;10539.57841686324 12:13:03 INFO - PROCESS | 26677 | __end_tp_report 12:13:03 INFO - PROCESS | 26677 | __start_cc_report 12:13:03 INFO - PROCESS | 26677 | _x_x_mozilla_cycle_collect,345 12:13:03 INFO - PROCESS | 26677 | __end_cc_report 12:13:03 INFO - PROCESS | 26677 | __startTimestamp1464894783215__endTimestamp 12:13:03 INFO - PROCESS | 26677 | 12:13:03 INFO - PROCESS | 26677 | ------- Summary: start ------- 12:13:03 INFO - PROCESS | 26677 | Number of tests: 6 12:13:03 INFO - PROCESS | 26677 | 12:13:03 INFO - PROCESS | 26677 | [#0] dojo.html Cycles:165 Average:5438.93 Median:5658.32 stddev:720.20 (12.7%) stddev-sans-first:699.43 12:13:03 INFO - PROCESS | 26677 | Values: 3138.6 3158.4 3186.8 3197.7 3212.2 5387.2 5425.2 5432.7 5452.1 5513.3 5373.7 5456.8 5487.4 5505.7 5529.1 4981.8 4985.1 5083.9 5128.8 5177.7 766.6 5002.4 5009.9 5042.5 5106.8 5013.7 5046.5 5066.5 5068.1 5092.8 4974.7 5055.6 5081.5 5085.3 5086.6 4980.4 4984.1 4993.4 5020.8 5042.6 5356.5 5362.3 5390.5 5403.0 5446.0 5685.0 5766.7 5787.5 5896.2 5903.4 5885.5 5920.7 5938.6 5951.3 5991.7 5541.4 5551.3 5565.1 5567.7 5569.1 5826.9 5985.4 6026.2 6056.1 6067.5 5813.7 5815.1 5839.1 5844.1 5874.1 5883.2 5917.4 5922.3 5950.8 5951.5 5659.7 5809.9 5814.7 5864.5 5888.6 5715.2 5795.7 5798.8 5835.2 5930.7 4456.1 4465.2 4470.8 4473.4 4514.9 3895.3 3923.6 3944.1 4005.1 4008.3 5604.2 5649.0 5653.7 5656.0 5700.7 5757.9 5909.9 5975.7 5980.9 6009.5 5526.8 5574.9 5584.4 5585.2 5625.4 5075.7 5091.6 5096.3 5103.0 5147.0 5935.0 5975.8 6138.2 6164.2 6168.7 5836.1 5949.2 5956.7 5958.2 5985.6 6056.1 6069.2 6086.4 6097.5 6102.1 5658.3 5700.2 5717.4 5819.8 5829.4 5878.3 5887.6 5935.8 5936.5 5974.7 5705.1 5722.5 5727.9 5750.8 5756.7 5474.3 5666.4 5747.7 5771.5 5787.6 5493.9 5558.4 5613.3 5615.6 5647.4 5825.9 5832.6 5850.0 5863.4 5867.5 5515.1 5608.8 5655.8 5658.3 5724.2 12:13:03 INFO - PROCESS | 26677 | 12:13:03 INFO - PROCESS | 26677 | [#1] ext.html Cycles:180 Average:61020.93 Median:42941.07 stddev:126126.43 (293.7%) stddev-sans-first:126398.63 12:13:03 INFO - PROCESS | 26677 | Values: 587.7 618.7 626.0 645.8 651.9 33403.2 37037.0 43806.0 45206.8 45245.8 46489.0 46547.5 46745.8 47118.5 47182.3 8682.2 8807.6 8817.1 8820.5 8831.8 8754.3 8783.7 8834.2 8848.0 8859.3 8819.6 8859.0 8896.0 8909.8 8912.3 8776.3 8786.5 8847.8 8874.4 8886.8 8758.1 8902.7 8913.4 8915.9 8924.2 43198.6 43610.0 43687.1 43692.3 43696.0 3405.5 3461.3 3555.7 3562.8 3978.0 32861.0 32945.0 33157.4 33321.0 34219.8 4246.7 4308.3 4309.4 4377.2 4540.3 251671.0 251864.0 252227.0 252867.0 253397.0 58844.0 59239.4 59374.7 59387.7 59555.0 36225.5 37282.0 37415.8 65902.0 66196.7 17623.0 18081.5 18125.8 18136.4 18228.7 12810.4 12828.1 12847.9 12915.8 12925.9 19478.5 19529.5 19532.1 19546.2 19580.8 7391.9 7441.4 7579.2 7634.8 7746.1 1031.2 1079.5 1159.0 1209.5 1253.9 32936.8 32962.8 33165.3 33563.2 33620.1 1076.8 1095.7 1102.0 1167.0 1216.3 17022.0 17424.5 17557.1 17645.7 17851.1 622444.0 622566.0 626394.0 626637.0 631252.0 60863.4 60888.4 61954.4 61974.7 62142.0 1330.6 1362.8 1370.4 1374.3 1396.4 30050.4 31230.0 31608.7 32103.0 32491.7 52818.5 53312.7 53652.5 53666.2 53699.7 457879.0 458045.0 463824.0 465598.0 466483.0 28191.0 28466.9 28738.4 28739.3 28741.9 48649.5 49742.5 50034.5 50576.7 51172.2 41966.8 43173.4 43227.6 43725.8 44216.0 41276.6 41618.0 42407.8 42583.4 42894.1 41675.8 41762.8 42327.8 42378.0 42988.0 35456.5 37140.5 37159.8 37808.6 38144.2 27561.0 28745.6 28773.7 28791.3 28859.4 12:13:03 INFO - PROCESS | 26677 | 12:13:03 INFO - PROCESS | 26677 | [#2] jquery.html Cycles:180 Average:30362.77 Median:3702.57 stddev:78115.63 (2109.8%) stddev-sans-first:78302.34 12:13:03 INFO - PROCESS | 26677 | Values: 390.4 396.6 397.0 397.3 412.0 18146.8 19526.6 19949.9 19951.1 20205.3 18638.4 19155.3 19378.6 20294.7 20317.1 6348.9 6381.3 6587.5 6592.9 6599.6 6458.4 6460.6 6496.3 6542.6 6560.1 6714.2 6839.0 6957.0 6959.7 6968.4 6984.4 7172.1 7209.7 7233.3 7243.3 7025.5 7064.0 7088.1 7104.6 7118.4 24954.0 25562.6 26243.9 26508.5 26687.7 2198.4 2271.7 2286.7 2371.7 2422.1 15133.3 15613.5 15695.5 15960.6 16231.6 1863.2 1901.8 1990.2 2004.3 2069.0 93751.0 96862.5 97565.0 98898.0 99795.5 17260.9 18013.8 18167.8 18483.4 18520.2 31934.5 32591.5 32641.3 32663.3 32758.3 9841.5 9875.8 9906.1 10151.0 10213.7 8201.6 8295.5 8341.2 8443.7 8510.4 8678.5 8839.1 8918.7 8952.0 9077.2 3432.7 3487.8 3659.7 3700.4 3704.7 910.9 971.9 1001.4 1072.9 1076.3 18771.5 19168.3 19570.9 19683.5 19817.7 952.4 991.3 1003.0 1010.6 1024.4 9120.6 10656.7 10665.9 10724.5 10763.5 454849.0 459738.0 460036.0 466877.0 513675.0 92578.5 94487.5 97239.0 97582.5 97904.5 941.8 964.2 994.8 1017.2 1026.0 16476.6 16963.9 17005.8 17040.9 17370.3 41583.2 42676.4 42713.8 44011.1 44065.8 58362.0 59602.4 59857.4 59963.4 60444.0 7422.4 7750.7 7833.3 7870.4 7933.8 9548.5 12183.5 12610.9 13548.5 13839.3 11690.2 12076.2 12170.8 12293.9 12489.8 5550.2 10878.0 11467.9 11539.1 11589.8 10994.4 11987.7 12306.3 12390.3 12410.4 8607.7 8742.1 8749.7 8959.7 8986.0 11316.3 12003.9 12018.7 12019.8 12136.2 12:13:03 INFO - PROCESS | 26677 | 12:13:03 INFO - PROCESS | 26677 | [#3] mootools.html Cycles:180 Average:5614.02 Median:4861.06 stddev:3168.14 (65.2%) stddev-sans-first:3161.80 12:13:03 INFO - PROCESS | 26677 | Values: 1481.1 1494.5 1665.4 1789.1 1807.8 7628.6 8140.0 8253.8 8750.4 8830.9 8023.1 8270.6 8342.7 8343.0 8343.6 2299.7 2313.6 2322.8 2339.0 2345.6 2306.9 2309.7 2346.5 2350.8 2359.1 2327.9 2328.8 2329.7 2367.7 2375.6 2296.1 2323.4 2337.3 2342.2 2343.3 2230.6 2234.0 2251.8 2258.8 2260.2 8428.2 8478.4 8494.1 8501.8 8522.4 5072.1 5232.7 5268.8 5277.4 5302.0 3218.7 3406.0 3450.3 3461.0 3478.2 1156.5 1157.0 1207.3 1236.1 1246.7 11771.2 11787.9 11823.5 11842.6 11849.6 4608.4 4629.2 4723.2 4743.0 4751.0 9991.8 10032.5 10066.4 10082.7 10099.9 5112.1 5181.0 5199.8 5265.0 5280.5 4219.0 4710.9 4784.7 4845.9 4855.3 3960.8 3984.8 4046.8 4099.0 4108.9 1297.0 1301.2 1305.6 1305.7 1305.8 928.1 940.1 957.8 960.1 988.5 5483.8 5540.9 5589.9 5693.2 5809.6 463.3 465.3 473.2 474.1 474.8 3685.9 3724.9 3730.5 3737.8 3848.1 10362.1 10623.9 10688.2 10708.9 10731.6 10293.2 10506.3 10507.5 10549.2 10562.9 7802.0 7849.2 7931.8 7964.4 7983.8 5555.9 5616.2 5646.2 5677.7 5720.3 9725.3 9801.0 9807.5 9813.8 9815.6 9701.6 9909.8 9928.7 9959.5 9994.6 6717.7 7122.7 7244.9 7418.7 7561.9 8216.6 8243.4 8251.2 8277.1 8316.5 7310.3 7560.4 7561.3 7582.0 7713.5 7383.1 7404.4 7499.4 7531.5 7551.2 6681.6 6698.6 6712.6 6718.9 6742.5 4722.8 4866.8 4881.4 4907.0 4925.9 4808.2 4934.1 4948.3 5000.6 5164.1 12:13:03 INFO - PROCESS | 26677 | 12:13:03 INFO - PROCESS | 26677 | [#4] prototype.html Cycles:180 Average:4903.27 Median:5496.29 stddev:1465.53 (26.7%) stddev-sans-first:1428.78 12:13:03 INFO - PROCESS | 26677 | Values: 324.7 330.4 336.3 338.0 339.1 5459.8 5657.6 5675.4 5730.6 5732.9 5569.5 5590.7 5610.9 5619.2 5660.8 4427.3 4444.0 4454.7 4472.4 4497.8 4335.4 4395.6 4422.5 4439.7 4446.4 4386.6 4387.9 4406.4 4425.5 4442.3 4396.2 4433.4 4438.9 4443.9 4483.8 3595.4 3789.2 3826.9 3963.5 3976.7 5494.1 5494.3 5503.1 5513.9 5514.0 4933.2 4945.2 4997.7 5000.8 5008.4 5801.7 5885.9 5909.5 5911.6 5949.5 4093.2 4173.3 4179.3 4185.7 4193.2 5830.9 5950.9 6084.6 6114.4 6115.9 4204.5 4207.8 4219.4 4234.8 4235.4 4281.6 4296.8 4300.4 4306.8 4335.7 4836.3 4921.8 4982.7 5006.4 5016.8 5884.6 5892.0 5910.5 5927.2 5985.8 1463.3 1487.8 1491.5 1496.2 1499.4 912.5 934.3 956.0 956.0 963.7 5062.0 5074.0 5081.6 5109.9 5125.8 5334.5 5353.7 5378.8 5381.7 5464.2 4917.7 4979.6 5052.0 5094.2 5135.4 2862.8 2879.6 2900.9 2904.4 2917.7 5434.3 5457.0 5498.3 5501.6 5526.4 5423.3 5830.4 6274.0 6322.7 6335.3 6348.3 6390.6 6418.4 6419.9 6420.1 5962.1 6156.9 6161.6 6202.8 6231.5 6098.5 6101.6 6102.6 6159.9 6179.4 6105.4 6137.6 6283.7 6297.2 6315.5 4275.9 4290.9 4319.1 4327.4 4330.1 5800.9 6139.7 6176.1 6184.3 6191.4 5896.9 5912.9 5919.5 6030.7 6093.6 5949.3 6014.7 6018.5 6034.0 6037.7 5622.2 5919.8 5927.5 5932.2 5935.5 6003.7 6027.0 6056.3 6080.6 6080.9 5628.6 5911.7 5916.5 5922.2 5931.8 12:13:03 INFO - PROCESS | 26677 | 12:13:03 INFO - PROCESS | 26677 | [#5] yui.html Cycles:180 Average:15843.91 Median:25679.10 stddev:19354.38 (75.4%) stddev-sans-first:19375.38 12:13:03 INFO - PROCESS | 26677 | Values: 726.3 806.6 806.8 829.2 853.8 13970.6 14789.6 14871.2 14935.4 14977.0 13551.1 13664.3 13768.7 13773.5 13841.2 819.9 831.9 836.9 838.7 839.0 814.7 837.6 837.9 841.8 843.1 882.8 884.3 885.6 886.2 887.5 872.4 874.5 878.1 880.6 882.3 632.4 636.9 640.2 640.5 640.7 14560.2 14647.0 14708.3 14720.9 14733.4 13717.9 13741.8 13776.8 13860.2 13905.3 11739.6 11808.8 11848.1 11985.9 12089.9 3741.1 3813.9 3819.2 3845.3 3939.6 60933.0 61715.1 61876.4 62074.4 62193.4 10017.2 10252.5 10271.7 10410.7 10512.8 19911.1 19954.2 20004.7 20025.8 20046.9 8398.0 8423.5 8570.2 8580.6 8620.1 4795.9 4805.4 4807.3 4833.8 4928.4 3307.4 3452.5 3465.9 3467.9 3482.4 576.6 589.1 595.0 602.1 607.9 649.8 720.2 730.7 746.0 749.7 9189.3 9517.3 9619.0 9619.8 9636.5 650.4 730.2 748.3 751.7 767.1 4323.7 4491.8 4589.5 4627.2 4634.4 70203.3 70715.3 70876.6 71386.0 71564.1 46562.3 48926.8 59461.7 64619.0 65537.0 57259.7 58079.0 58218.0 58731.7 59090.7 8928.9 8942.4 8977.2 8988.9 8997.4 37827.0 37980.8 38179.4 38608.0 39096.2 48330.3 51902.2 52022.0 52254.5 52836.0 11337.4 11388.1 11459.6 11751.6 12049.9 12974.1 13072.9 13077.5 13153.8 13476.2 12135.4 12228.3 12235.3 12990.0 13090.3 12202.4 12447.9 12587.1 12777.7 12791.0 11817.6 12392.7 12427.3 12445.3 12641.2 10112.5 10182.5 10351.0 10580.8 10585.6 10209.6 10324.3 10369.9 10477.6 10539.6 12:13:03 INFO - PROCESS | 26677 | -------- Summary: end -------- 12:13:03 INFO - PROCESS | 26677 | 12:13:03 INFO - TEST-INFO | 26677: exit 0 12:13:03 INFO - TEST-OK | dromaeo_css | took 1110440ms 12:13:03 INFO - TEST-START | kraken 12:13:03 INFO - operating with platform_type : linux_ 12:13:03 INFO - Initialising browser for kraken test... 12:13:03 INFO - TEST-INFO | started process 26912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU2kKef/profile http://localhost:49264/getInfo.html) 12:13:08 INFO - PROCESS | 26912 | __metrics Screen width/height:1600/1200 12:13:08 INFO - PROCESS | 26912 | colorDepth:24 12:13:08 INFO - PROCESS | 26912 | Browser inner width/height: 1024/697 12:13:08 INFO - PROCESS | 26912 | __metrics 12:13:09 ERROR - PROCESS | 26912 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 12:13:10 INFO - TEST-INFO | 26912: exit 0 12:13:10 INFO - Browser initialized. 12:13:10 INFO - Running cycle 1/1 for kraken test... 12:13:10 INFO - TEST-INFO | started process 27036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU2kKef/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:13:22 INFO - PROCESS | 27036 | RSS: Main: 167006208 12:13:22 INFO - PROCESS | 27036 | 12:13:24 INFO - PROCESS | 27036 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 12:13:25 INFO - PROCESS | 27036 | RSS: Main: 172785664 12:13:25 INFO - PROCESS | 27036 | 12:13:28 INFO - PROCESS | 27036 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 12:13:28 INFO - PROCESS | 27036 | RSS: Main: 172195840 12:13:28 INFO - PROCESS | 27036 | 12:13:31 INFO - PROCESS | 27036 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 12:13:32 INFO - PROCESS | 27036 | RSS: Main: 166629376 12:13:32 INFO - PROCESS | 27036 | 12:13:34 INFO - PROCESS | 27036 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 12:13:35 INFO - PROCESS | 27036 | RSS: Main: 167649280 12:13:35 INFO - PROCESS | 27036 | 12:13:37 INFO - PROCESS | 27036 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:13:38 INFO - PROCESS | 27036 | RSS: Main: 167882752 12:13:38 INFO - PROCESS | 27036 | 12:13:41 INFO - PROCESS | 27036 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 12:13:41 INFO - PROCESS | 27036 | RSS: Main: 168366080 12:13:41 INFO - PROCESS | 27036 | 12:13:45 INFO - PROCESS | 27036 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 12:13:45 INFO - PROCESS | 27036 | RSS: Main: 168169472 12:13:45 INFO - PROCESS | 27036 | 12:13:48 INFO - PROCESS | 27036 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 12:13:49 INFO - PROCESS | 27036 | RSS: Main: 168214528 12:13:49 INFO - PROCESS | 27036 | 12:13:51 INFO - PROCESS | 27036 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:13:51 INFO - PROCESS | 27036 | RSS: Main: 168050688 12:13:51 INFO - PROCESS | 27036 | 12:13:53 INFO - PROCESS | 27036 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:13:54 INFO - PROCESS | 27036 | RSS: Main: 168603648 12:13:54 INFO - PROCESS | 27036 | 12:13:56 INFO - PROCESS | 27036 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:13:56 INFO - PROCESS | 27036 | RSS: Main: 169140224 12:13:56 INFO - PROCESS | 27036 | 12:13:59 INFO - PROCESS | 27036 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:14:00 INFO - PROCESS | 27036 | RSS: Main: 168996864 12:14:00 INFO - PROCESS | 27036 | 12:14:02 INFO - PROCESS | 27036 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:14:03 INFO - PROCESS | 27036 | RSS: Main: 169246720 12:14:03 INFO - PROCESS | 27036 | 12:14:04 INFO - PROCESS | 27036 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 12:14:05 INFO - PROCESS | 27036 | RSS: Main: 170254336 12:14:05 INFO - PROCESS | 27036 | 12:14:05 INFO - PROCESS | 27036 | __start_tp_report 12:14:05 INFO - PROCESS | 27036 | _x_x_mozilla_page_load 12:14:05 INFO - PROCESS | 27036 | _x_x_mozilla_page_load_details 12:14:05 INFO - PROCESS | 27036 | |i|pagename|runs| 12:14:05 INFO - PROCESS | 27036 | |0;ai-astar;112;105;112;116;111;113;111;110;111;110 12:14:05 INFO - PROCESS | 27036 | |1;audio-beat-detection;154;125;165;177;127;155;152;129;184;129 12:14:05 INFO - PROCESS | 27036 | |2;audio-dft;165;163;161;160;164;174;161;164;160;166 12:14:05 INFO - PROCESS | 27036 | |3;audio-fft;75;75;74;170;74;74;75;74;159;77 12:14:05 INFO - PROCESS | 27036 | |4;audio-oscillator;83;87;155;84;82;81;154;86;82;130 12:14:05 INFO - PROCESS | 27036 | |5;imaging-gaussian-blur;120;118;118;117;120;122;117;117;117;121 12:14:05 INFO - PROCESS | 27036 | |6;imaging-darkroom;146;147;146;147;146;147;146;147;146;149 12:14:05 INFO - PROCESS | 27036 | |7;imaging-desaturate;99;100;99;99;95;96;100;100;95;95 12:14:05 INFO - PROCESS | 27036 | |8;json-parse-financial;54;54;60;55;54;55;57;58;55;54 12:14:05 INFO - PROCESS | 27036 | |9;json-stringify-tinderbox;61;61;61;62;62;62;61;62;62;63 12:14:05 INFO - PROCESS | 27036 | |10;stanford-crypto-aes;79;79;80;80;82;80;80;79;103;82 12:14:05 INFO - PROCESS | 27036 | |11;stanford-crypto-ccm;123;124;137;128;122;132;138;135;137;122 12:14:05 INFO - PROCESS | 27036 | |12;stanford-crypto-pbkdf2;164;160;166;163;164;163;159;161;159;171 12:14:05 INFO - PROCESS | 27036 | |13;stanford-crypto-sha256-iterative;63;64;64;64;62;62;63;63;62;64 12:14:05 INFO - PROCESS | 27036 | __end_tp_report 12:14:05 INFO - PROCESS | 27036 | __start_cc_report 12:14:05 INFO - PROCESS | 27036 | _x_x_mozilla_cycle_collect,885 12:14:05 INFO - PROCESS | 27036 | __end_cc_report 12:14:05 INFO - PROCESS | 27036 | __startTimestamp1464894845249__endTimestamp 12:14:05 INFO - PROCESS | 27036 | 12:14:05 INFO - PROCESS | 27036 | ------- Summary: start ------- 12:14:05 INFO - PROCESS | 27036 | Number of tests: 14 12:14:05 INFO - PROCESS | 27036 | 12:14:05 INFO - PROCESS | 27036 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.50 stddev:2.77 (2.5%) stddev-sans-first:2.92 12:14:05 INFO - PROCESS | 27036 | Values: 112.0 105.0 112.0 116.0 111.0 113.0 111.0 110.0 111.0 110.0 12:14:05 INFO - PROCESS | 27036 | 12:14:05 INFO - PROCESS | 27036 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:154.50 stddev:21.58 (14.0%) stddev-sans-first:22.83 12:14:05 INFO - PROCESS | 27036 | Values: 154.0 125.0 165.0 177.0 127.0 155.0 152.0 129.0 184.0 129.0 12:14:05 INFO - PROCESS | 27036 | 12:14:05 INFO - PROCESS | 27036 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:4.16 (2.5%) stddev-sans-first:4.39 12:14:05 INFO - PROCESS | 27036 | Values: 165.0 163.0 161.0 160.0 164.0 174.0 161.0 164.0 160.0 166.0 12:14:05 INFO - PROCESS | 27036 | 12:14:05 INFO - PROCESS | 27036 | [#3] audio-fft Cycles:10 Average:92.70 Median:74.50 stddev:37.94 (50.9%) stddev-sans-first:39.70 12:14:05 INFO - PROCESS | 27036 | Values: 75.0 75.0 74.0 170.0 74.0 74.0 75.0 74.0 159.0 77.0 12:14:05 INFO - PROCESS | 27036 | 12:14:05 INFO - PROCESS | 27036 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:82.50 stddev:31.10 (37.7%) stddev-sans-first:32.18 12:14:05 INFO - PROCESS | 27036 | Values: 83.0 87.0 155.0 84.0 82.0 81.0 154.0 86.0 82.0 130.0 12:14:05 INFO - PROCESS | 27036 | 12:14:05 INFO - PROCESS | 27036 | [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:119.00 stddev:1.89 (1.6%) stddev-sans-first:1.94 12:14:05 INFO - PROCESS | 27036 | Values: 120.0 118.0 118.0 117.0 120.0 122.0 117.0 117.0 117.0 121.0 12:14:05 INFO - PROCESS | 27036 | 12:14:05 INFO - PROCESS | 27036 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 12:14:05 INFO - PROCESS | 27036 | Values: 146.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 149.0 12:14:05 INFO - PROCESS | 27036 | 12:14:05 INFO - PROCESS | 27036 | [#7] imaging-desaturate Cycles:10 Average:97.80 Median:95.50 stddev:2.25 (2.4%) stddev-sans-first:2.35 12:14:05 INFO - PROCESS | 27036 | Values: 99.0 100.0 99.0 99.0 95.0 96.0 100.0 100.0 95.0 95.0 12:14:05 INFO - PROCESS | 27036 | 12:14:05 INFO - PROCESS | 27036 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:2.07 (3.8%) stddev-sans-first:2.11 12:14:05 INFO - PROCESS | 27036 | Values: 54.0 54.0 60.0 55.0 54.0 55.0 57.0 58.0 55.0 54.0 12:14:05 INFO - PROCESS | 27036 | 12:14:05 INFO - PROCESS | 27036 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 12:14:05 INFO - PROCESS | 27036 | Values: 61.0 61.0 61.0 62.0 62.0 62.0 61.0 62.0 62.0 63.0 12:14:05 INFO - PROCESS | 27036 | 12:14:05 INFO - PROCESS | 27036 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:80.00 stddev:7.32 (9.2%) stddev-sans-first:7.66 12:14:05 INFO - PROCESS | 27036 | Values: 79.0 79.0 80.0 80.0 82.0 80.0 80.0 79.0 103.0 82.0 12:14:05 INFO - PROCESS | 27036 | 12:14:05 INFO - PROCESS | 27036 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:133.50 stddev:6.73 (5.0%) stddev-sans-first:6.67 12:14:05 INFO - PROCESS | 27036 | Values: 123.0 124.0 137.0 128.0 122.0 132.0 138.0 135.0 137.0 122.0 12:14:05 INFO - PROCESS | 27036 | 12:14:05 INFO - PROCESS | 27036 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:163.50 stddev:3.65 (2.2%) stddev-sans-first:3.86 12:14:05 INFO - PROCESS | 27036 | Values: 164.0 160.0 166.0 163.0 164.0 163.0 159.0 161.0 159.0 171.0 12:14:05 INFO - PROCESS | 27036 | 12:14:05 INFO - PROCESS | 27036 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:0.88 (1.4%) stddev-sans-first:0.93 12:14:05 INFO - PROCESS | 27036 | Values: 63.0 64.0 64.0 64.0 62.0 62.0 63.0 63.0 62.0 64.0 12:14:05 INFO - PROCESS | 27036 | -------- Summary: end -------- 12:14:05 INFO - PROCESS | 27036 | 12:14:06 INFO - TEST-INFO | 27036: exit 0 12:14:06 INFO - TEST-OK | kraken | took 62287ms 12:14:06 INFO - SUITE-END | took 1172s 12:14:06 INFO - Completed test suite (00:19:32) 12:14:06 INFO - javascript benchmark 12:14:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7334.925700156388, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3138.623365196177, 3158.447271727448, 3186.792858464201, 3197.6962188592083, 3212.2130078130863, 5387.245785590016, 5425.213344065108, 5432.701201433914, 5452.127659574468, 5513.283273174482, 5373.704446255454, 5456.8090116845915, 5487.42382049885, 5505.697186654733, 5529.087700529418, 4981.775820088104, 4985.102681517325, 5083.872903177413, 5128.794848206067, 5177.715225662587, 766.5611580061474, 5002.374703162105, 5009.899802003958, 5042.520960508746, 5106.846794596168, 5013.749312534395, 5046.470120637336, 5066.544011039005, 5068.06240845443, 5092.84721458355, 4974.651774375795, 5055.646104772667, 5081.517255860687, 5085.313482679828, 5086.643934924557, 4980.352554167971, 4984.053029924303, 4993.400791904958, 5020.799168033274, 5042.647014708972, 5356.464353564651, 5362.329708786402, 5390.51485366319, 5402.9729851350885, 5445.9652665993335, 5684.971575142098, 5766.740496677618, 5787.50806181475, 5896.233489646362, 5903.380145084747, 5885.4997325227405, 5920.721528764009, 5938.643681379088, 5951.2858456985, 5991.730372133265, 5541.445855414467, 5551.278333816578, 5565.0817615093465, 5567.721613919288, 5569.053260945609, 5826.941730582725, 5985.371535988658, 6026.246719160105, 6056.121862329937, 6067.514598832083, 5813.680247586423, 5815.098659707752, 5839.065749480063, 5844.0941654042845, 5874.089516125007, 5883.17635531026, 5917.437843404869, 5922.3485416605, 5950.821475355746, 5951.5238780897425, 5659.745311460994, 5809.8547536311935, 5814.709264536757, 5864.501517370986, 5888.558358123072, 5715.228444160069, 5795.710214489259, 5798.768049278066, 5835.212246346774, 5930.673812940329, 4456.108778244364, 4465.173942820524, 4470.754108523997, 4473.373727678128, 4514.932276015862, 3895.2793733159456, 3923.588023257517, 3944.073142811437, 4005.0788318686864, 4008.2985477541315, 5604.243427137284, 5648.971755141198, 5653.660780353192, 5656.0, 5700.657960522382, 5757.88484230313, 5909.911351329733, 5975.731092100866, 5980.85047873798, 6009.459148676553, 5526.751296191681, 5574.860628484239, 5584.385717571064, 5585.218069470277, 5625.38120806711, 5075.670081444694, 5091.5672167865405, 5096.311997880312, 5102.979404119191, 5147.0, 5934.970325148347, 5975.7609695612555, 6138.202033735675, 6164.198654175018, 6168.660723660152, 5836.095405212199, 5949.167116603766, 5956.731947062306, 5958.225430694156, 5985.610935289105, 6056.121862330026, 6069.211002569814, 6086.360932102242, 6097.512199024156, 6102.115193297036, 5658.349289831722, 5700.2304688868135, 5717.371089180104, 5819.82540523785, 5829.446202610745, 5878.29460464747, 5887.58786884931, 5935.762569497172, 5936.525077993837, 5974.671393073423, 5705.144228365612, 5722.484976352148, 5727.8854422912145, 5750.769969201185, 5756.740946657326, 5474.288342515448, 5666.433356664301, 5747.712614369349, 5771.451712087345, 5787.56593255516, 5493.890122197614, 5558.388577256418, 5613.270274864241, 5615.578831587729, 5647.3505546861, 5825.94174058271, 5832.562557808096, 5850.0, 5863.413658634273, 5867.471927526543, 5515.145152501369, 5608.803691870765, 5655.802046928337, 5658.321001479849, 5724.169995350734], "value": 5392.216916330852, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.6503480429146, 618.7030225491761, 626.0484064222383, 645.825627080688, 651.8500744828692, 33403.16492087696, 37037.0, 43806.0, 45206.773966130204, 45245.7737711311, 46489.0, 46547.534524654744, 46745.76627116868, 47118.52881471184, 47182.292265616044, 8682.175193356637, 8807.64769409226, 8817.118288171196, 8820.470771753684, 8831.77920551985, 8754.255888249507, 8783.692570760024, 8834.204921557091, 8847.95576022119, 8859.335549833757, 8819.603117859711, 8859.025507194203, 8896.021437641853, 8909.821803563926, 8912.331575131859, 8776.341774366916, 8786.472811631258, 8847.823043539092, 8874.42316249445, 8886.777830554223, 8758.12418758119, 8902.73291801247, 8913.376063675545, 8915.866262006075, 8924.152205540464, 43198.56801431977, 43610.0, 43687.12625747499, 43692.3446148308, 43696.0, 3405.540252065964, 3461.273132642123, 3555.7333200010103, 3562.839672214757, 3977.9657289104753, 32861.0, 32945.01164965055, 33157.35898766513, 33321.0, 34219.82890085533, 4246.6602671786495, 4308.253334064001, 4309.41822853917, 4377.190219809346, 4540.341650460698, 251671.0, 251864.0, 252226.99999999817, 252867.0, 253397.0, 58844.0, 59239.40760592425, 59374.70312648409, 59387.70306148528, 59555.0, 36225.45661815075, 37282.0, 37415.812920935765, 65902.0, 66196.66901665558, 17623.0, 18081.547961301072, 18125.818741812676, 18136.365227216986, 18228.726569101473, 12810.359482025862, 12828.10203285761, 12847.935760321325, 12915.806262906064, 12925.935370323088, 19478.513037174183, 19529.511762206057, 19532.12105455258, 19546.218151274075, 19580.804191957897, 7391.852162956819, 7441.441891858132, 7579.242075792376, 7634.770182425056, 7746.147923728386, 1031.2162756305263, 1079.5304042741432, 1158.965231043053, 1209.5403746576244, 1253.924764514132, 32936.835315823264, 32962.83518582392, 33165.336693266, 33563.16092097717, 33620.1171584613, 1076.7523469602036, 1095.7315457712912, 1101.9944900275448, 1166.976660466786, 1216.3492531495608, 17022.017317438273, 17424.47726568205, 17557.122143892753, 17645.7353139703, 17851.107444627716, 622444.0, 622566.0, 626394.0, 626637.0, 631252.0, 60863.39136608666, 60888.39111608827, 61954.380456194864, 61974.69012654908, 62142.0, 1330.6274243211917, 1362.768329384007, 1370.4244217428504, 1374.2579007335926, 1396.427464739452, 30050.398992020473, 31230.0, 31608.683913161494, 32103.0, 32491.675083248865, 52818.47181528136, 53312.73343633257, 53652.46347536475, 53666.195007074144, 53699.73150134224, 457879.0, 458045.0, 463824.0, 465598.0, 466483.0, 28191.0, 28466.857665711537, 28738.425231495672, 28739.28151796222, 28741.856290718413, 48649.513504864495, 49742.50257497379, 50034.49965500298, 50576.74711626418, 51172.232416514526, 41966.79016604897, 43173.3523997134, 43227.56772432361, 43725.78137109294, 44216.0, 41276.58723412728, 41618.0, 42407.78796106, 42583.3612495819, 42894.14211715811, 41675.7916210417, 41762.791186043876, 42327.788361057996, 42378.0, 42988.0, 35456.46815297824, 37140.517605022425, 37159.81420092882, 37808.62191378051, 38144.237115258096, 27561.0, 28745.568816467352, 28773.712262877103, 28791.280217994718, 28859.42281154323], "value": 20370.360998062904, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.39293897988625, 396.62122672847397, 396.9980150099249, 397.29876767505357, 412.0276148290035, 18146.81853181468, 19526.609467810635, 19949.900250498762, 19951.10220040098, 20205.292814751487, 18638.440846774585, 19155.329563465246, 19378.612427751435, 20294.69557956632, 20317.0857311421, 6348.936510634892, 6381.298057213703, 6587.473002159816, 6592.934070659304, 6599.604023758566, 6458.418742313191, 6460.644664543448, 6496.285408605049, 6542.607443553402, 6560.147180866505, 6714.194296684404, 6838.9658051709675, 6956.965215173917, 6959.721611135548, 6968.44252459802, 6984.4412447004115, 7172.103487064117, 7209.675564599579, 7233.276672332751, 7243.275672432767, 7025.543339682956, 7063.964680176618, 7088.113985751781, 7104.644767761643, 7118.39493643041, 24954.0, 25562.616560751605, 26243.868780655976, 26508.469830603473, 26687.733122668913, 2198.3844523533435, 2271.65925111233, 2286.67986481891, 2371.6916800815957, 2422.1401402502033, 15133.319000644888, 15613.453529126426, 15695.450659226986, 15960.600984975352, 16231.59421014484, 1863.1522657190947, 1901.8288354048202, 1990.2138655231104, 2004.3485867093252, 2069.0031933966725, 93751.0, 96862.51568742182, 97565.0, 98898.0, 99795.50102249443, 17260.91369543144, 18013.819861801214, 18167.818321816878, 18483.445496635122, 18520.16659250337, 31934.520982185284, 32591.511127332633, 32641.347173056405, 32663.346733065682, 32758.344833103205, 9841.50792460374, 9875.802483950425, 9906.05892440217, 10151.0, 10213.693589192337, 8201.630926608317, 8295.502269863828, 8341.249287564027, 8443.704470343508, 8510.404271700922, 8678.479291242546, 8839.116088391109, 8918.687845925362, 8951.955240223757, 9077.23144440952, 3432.7253819694365, 3487.755857089979, 3659.7255205859665, 3700.444933259979, 3704.68510176638, 910.8770316007254, 971.946542940145, 1001.439194051319, 1072.9248952573246, 1076.2573824061528, 18771.530711732044, 19168.329108481135, 19570.90214548918, 19683.507912302022, 19817.702734458995, 952.3904700991371, 991.2664628175243, 1003.0070230471927, 1010.6210171185805, 1024.446798728693, 9120.589573469077, 10656.680299591024, 10665.893341066645, 10724.463776811284, 10763.461826908624, 454849.0, 459738.0, 460036.0, 466877.0, 513675.0, 92578.53710731538, 94487.52756236175, 97239.0, 97582.51208743911, 97904.51047744715, 941.8257622339889, 964.1997142371814, 994.8159590475785, 1017.1557607186018, 1025.958961641541, 16476.588085297964, 16963.915180424512, 17005.82994170092, 17040.914795425942, 17370.305187792852, 41583.168336632494, 42676.35985460283, 42713.786431067645, 44011.11977760491, 44065.77967110144, 58362.0, 59602.40397596142, 59857.40142598518, 59963.40036599578, 60444.0, 7422.406207503279, 7750.689972401041, 7833.334166595903, 7870.370370370471, 7933.801654958442, 9548.52257387114, 12183.512659493521, 12610.936945315214, 13548.525801596898, 13839.308034598029, 11690.18168728215, 12076.154669173073, 12170.75658486843, 12293.877061229274, 12489.750204996031, 5550.195221692751, 10878.0, 11467.885321146681, 11539.134564907834, 11589.768204636028, 10994.395308258123, 11987.700307492383, 12306.323152226714, 12390.256584604953, 12410.441530130985, 8607.698730544402, 8742.125787421208, 8749.650013999624, 8959.686410975584, 8986.0, 11316.321020738782, 12003.879961200626, 12018.699532511757, 12019.75960480803, 12136.150469467053], "value": 10377.058341122764, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1481.081729327817, 1494.4993427201887, 1665.3671604790177, 1789.1143883777524, 1807.8282563156513, 7628.618569071552, 8140.0, 8253.752387428372, 8750.387472876893, 8830.867536986942, 8023.117457079717, 8270.586470676471, 8342.708005219818, 8343.0, 8343.582820858963, 2299.735530414003, 2313.571989181998, 2322.837401381904, 2338.96491552626, 2345.5660702769956, 2306.9192578259763, 2309.722833260011, 2346.495503466754, 2350.8119350452007, 2359.1035406545575, 2327.8603283803027, 2328.7671232876746, 2329.7087864017, 2367.6803631509697, 2375.5961486547244, 2296.115995341797, 2323.4191452136965, 2337.345543247885, 2342.1685301717816, 2343.2970108967243, 2230.631945728953, 2234.0393630738777, 2251.79733823955, 2258.7741225877444, 2260.242818655752, 8428.157184281585, 8478.364122690762, 8494.06565277819, 8501.787455313604, 8522.40343175978, 5072.112380333427, 5232.6860388376435, 5268.789248430058, 5277.419483856773, 5302.045631786277, 3218.7103160715646, 3405.9836736323255, 3450.3271861986923, 3460.9653903460894, 3478.2000139967695, 1156.468024708635, 1156.9537218511334, 1207.3480320626852, 1236.0729452910318, 1246.731952630189, 11771.23486973344, 11787.94106029473, 11823.467943942544, 11842.644720658394, 11849.585264515701, 4608.446986361658, 4629.166749984967, 4723.173444647173, 4742.9762851186215, 4750.95249047512, 9991.800163996679, 10032.548535315927, 10066.446345450924, 10082.69751907444, 10099.94950025245, 5112.079825631347, 5181.041507321158, 5199.844004679866, 5264.9736751315995, 5280.471952804689, 4218.978905105455, 4710.905781884343, 4784.712917224978, 4845.9030819383415, 4855.32025516428, 3960.7623542587535, 3984.7609143451486, 4046.838126474967, 4099.0, 4108.876733697994, 1296.9610911672664, 1301.1932601786953, 1305.6017914536158, 1305.6670549009941, 1305.8106574546637, 928.1182876267438, 940.1350757303297, 957.8467445208734, 960.0735290444754, 988.5353883674661, 5483.835484935458, 5540.889182216333, 5589.860253493695, 5693.231413759172, 5809.622374545641, 463.25647336025196, 465.2509459769768, 473.1554175796256, 474.11814025911775, 474.80532981477427, 3685.90785230366, 3724.906877328034, 3730.4963829882618, 3737.7944213068, 3848.134169811826, 10362.067413932782, 10623.893761062445, 10688.198385120992, 10708.946455267675, 10731.624393146358, 10293.228007899437, 10506.317089389166, 10507.527161277761, 10549.20880933933, 10562.894371056345, 7801.960990195126, 7849.175836537195, 7931.762047138595, 7964.402669799672, 7983.760487185394, 5555.8888822224135, 5616.1856530803625, 5646.209530665792, 5677.716114194356, 5720.256366672306, 9725.319227653996, 9801.0, 9807.509624518889, 9813.754656133653, 9815.55829987638, 9701.563429645541, 9909.752256193364, 9928.702138935843, 9959.452230127412, 9994.600215991279, 6717.664116794239, 7122.679479423335, 7244.891326630211, 7418.740344087931, 7561.924380756122, 8216.589170541329, 8243.422960392954, 8251.216134467217, 8277.130901255281, 8316.5425901576, 7310.342069213796, 7560.395168386626, 7561.281678240558, 7581.9926433722985, 7713.498622589514, 7383.07711536058, 7404.370628496638, 7499.362554182955, 7531.510451820614, 7551.244875512405, 6681.599104053772, 6698.56459330142, 6712.563683360566, 6718.865622687421, 6742.460603151834, 4722.834700785456, 4866.8053277868485, 4881.438634557071, 4906.975465122651, 4925.901481970269, 4808.182608956416, 4934.111859865258, 4948.331975183304, 5000.574951129195, 5164.070467315919], "value": 4463.154037628178, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.7418302449554, 330.40856866209486, 336.29042719861087, 337.9932401351973, 339.123366098635, 5459.808906688262, 5657.632253903494, 5675.404082571333, 5730.598858079931, 5732.939406209844, 5569.498745112939, 5590.692511911843, 5610.915836262459, 5619.2299425680885, 5660.830175094754, 4427.335899615051, 4444.0, 4454.688171827957, 4472.3515090311885, 4497.820087196525, 4335.43639326887, 4395.571588506033, 4422.535633758457, 4439.689221754478, 4446.355278484618, 4386.583274588925, 4387.934180987288, 4406.36107764374, 4425.4910685271125, 4442.289233722605, 4396.164728701537, 4433.379326894205, 4438.933415998763, 4443.888902777424, 4483.7758112094425, 3595.352836489431, 3789.2232092420986, 3826.9234615307814, 3963.5243770747406, 3976.741511801724, 5494.066008778517, 5494.2857428534435, 5503.147012213073, 5513.889722205574, 5514.0, 4933.235348520985, 4945.208766597363, 4997.675151115166, 5000.799968001275, 5008.398992120969, 5801.7389217485315, 5885.85285367865, 5909.497692696083, 5911.586188966774, 5949.512621844538, 4093.1813637272367, 4173.290540608074, 4179.328268692517, 4185.748855068675, 4193.203291374629, 5830.941690583125, 5950.899083669535, 6084.60450070744, 6114.419130182626, 6115.908261376083, 4204.474440694913, 4207.821809893235, 4219.43037689914, 4234.767087810138, 4235.385869048971, 4281.602302710492, 4296.763677997677, 4300.354946757949, 4306.763128027988, 4335.6965012449455, 4836.274558816206, 4921.827736029221, 4982.701037937735, 5006.374203224597, 5016.824411145592, 5884.617499862496, 5892.027815410409, 5910.468057874812, 5927.229460170151, 5985.790497332572, 1463.341496326636, 1487.7842712806582, 1491.4779827060659, 1496.2369191712305, 1499.3702644889172, 912.4525284829182, 934.2666007184328, 955.9569819358146, 956.0296299256122, 963.7012526116927, 5062.025809934129, 5074.01056793929, 5081.568066714297, 5109.8722531936255, 5125.820596279187, 5334.51989320963, 5353.699837161183, 5378.767811358242, 5381.735292206328, 5464.153056276284, 4917.690978772448, 4979.560015592406, 5051.974740126349, 5094.2103973884105, 5135.435102138762, 2862.7566656833988, 2879.5680647902564, 2900.8984685535906, 2904.390078083584, 2917.7082291770653, 5434.3207099112615, 5457.045017121988, 5498.285222920995, 5501.559875209973, 5526.364468086141, 5423.264555342332, 5830.387809279964, 6274.0, 6322.743786949724, 6335.334789847092, 6348.269948955837, 6390.552661313756, 6418.390252925965, 6419.903701444482, 6420.133282006869, 5962.135490353788, 6156.876862462636, 6161.599496032743, 6202.844928876814, 6231.470325022424, 6098.512119030378, 6101.603395779438, 6102.572819902742, 6159.938400615936, 6179.382061793965, 6105.419985101408, 6137.570370074231, 6283.74865005413, 6297.2128483939505, 6315.494760419064, 4275.87172384829, 4290.914181716411, 4319.11458151072, 4327.350897365421, 4330.069035157457, 5800.9419905800405, 6139.693015349126, 6176.135341052166, 6184.257889053342, 6191.442770150708, 5896.852578685567, 5912.852178695395, 5919.526437885045, 6030.652987591929, 6093.634381937098, 5949.3455719871645, 6014.729337179925, 6018.458338749533, 6033.9698301508215, 6037.728302226323, 5622.24099746529, 5919.792807251725, 5927.496162826208, 5932.199153114274, 5935.525157987265, 6003.729832157476, 6027.035674292092, 6056.3035250946705, 6080.574359794949, 6080.90878636812, 5628.634138780966, 5911.704414779158, 5916.467517923407, 5922.230110085661, 5931.792387266425], "value": 4428.571533198689, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.3027493606138, 806.612825843595, 806.7821688144197, 829.1584042197169, 853.7566793463864, 13970.580882573526, 14789.556313310592, 14871.182084985321, 14935.402583896659, 14977.0, 13551.119177253471, 13664.316784160777, 13768.724625507484, 13773.51792687256, 13841.238731869744, 819.9385046121535, 831.8669012957928, 836.9037560680539, 838.656150978099, 838.9706360277391, 814.7067055859885, 837.6398148796015, 837.9371547133959, 841.8400503904269, 843.0641987394018, 882.8057827277988, 884.3323290915382, 885.6014793342989, 886.1935638568904, 887.4763889305309, 872.4242000279849, 874.514644372373, 878.064860923118, 880.6037283222544, 882.3294296334767, 632.4371309534517, 636.9076483909854, 640.1965533255734, 640.5132099604288, 640.7308930249307, 14560.199189044704, 14646.97471177018, 14708.338124784303, 14720.926395368062, 14733.410663573444, 13717.931410342984, 13741.793873091812, 13776.793348099787, 13860.168389896638, 13905.304734763322, 11739.647810565697, 11808.822867656992, 11848.105298791239, 11985.880141198651, 12089.879101208964, 3741.1395379062697, 3813.866514671973, 3819.1597848473293, 3845.3078445879732, 3939.5666476687543, 60933.0, 61715.074273885926, 61876.38123618751, 62074.37925620686, 62193.37806621921, 10017.248706347053, 10252.538635761259, 10271.7432064199, 10410.68767936963, 10512.789744205073, 19911.10400032002, 19954.20183192685, 20004.69992950107, 20025.799742002684, 20046.89976550137, 8398.034226063959, 8423.536705481258, 8570.185832345916, 8580.570971451403, 8620.051794302623, 4795.904081918342, 4805.399325084364, 4807.302941073594, 4833.830815921426, 4928.359313289321, 3307.4377355849565, 3452.482127680868, 3465.8960231193105, 3467.878624248139, 3482.373172828915, 576.6136688418769, 589.0751520113381, 594.9970250148808, 602.1419477244908, 607.9179310793074, 649.76283656466, 720.1933834105835, 730.7332823519378, 745.9552426854406, 749.6655952404728, 9189.3108016899, 9517.333786635008, 9619.0, 9619.753676910083, 9636.46999415039, 650.3951325267547, 730.2223132364015, 748.3152915082638, 751.6880494594682, 767.0909971683573, 4323.6757243206885, 4491.752953587584, 4589.472210695746, 4627.236505976543, 4634.351190833286, 70203.2979670207, 70715.2928470719, 70876.64561677158, 71386.0, 71564.06397648179, 46562.30156547655, 48926.75536622294, 59461.702691486265, 64619.0, 65537.01694474586, 57259.713701431225, 58079.0, 58218.0, 58731.706341468016, 59090.70454647699, 8928.86606700887, 8942.418742781698, 8977.23693486061, 8988.86516702237, 8997.378049388577, 37827.0, 37980.810095949346, 38179.42730858984, 38608.0, 39096.21807563776, 48330.275045875045, 51902.221466678784, 52022.0, 52254.47745522496, 52836.0, 11337.388435008887, 11388.14588905852, 11459.598914037968, 11751.588694395656, 12049.879501204876, 12974.096785962553, 13072.934635326763, 13077.542286019943, 13153.802692959422, 13476.191428514321, 12135.393230338272, 12228.327441990776, 12235.32705701195, 12990.0, 13090.280034598189, 12202.435530796005, 12447.875521245034, 12587.11890167716, 12777.744445111231, 12791.0, 11817.586384476503, 12392.690182745504, 12427.31649759272, 12445.315507646805, 12641.2415255085, 10112.49437528106, 10182.49087545605, 10351.011786742822, 10580.84128738085, 10585.629502967358, 10209.642662506776, 10324.277300588887, 10369.896301036893, 10477.637907072032, 10539.57841686324], "value": 6911.650700904066, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 112.0, 116.0, 111.0, 113.0, 111.0, 110.0, 111.0, 110.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 165.0, 177.0, 127.0, 155.0, 152.0, 129.0, 184.0, 129.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 161.0, 160.0, 164.0, 174.0, 161.0, 164.0, 160.0, 166.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 170.0, 74.0, 74.0, 75.0, 74.0, 159.0, 77.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 155.0, 84.0, 82.0, 81.0, 154.0, 86.0, 82.0, 130.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 118.0, 117.0, 120.0, 122.0, 117.0, 117.0, 117.0, 121.0], "value": 118.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 149.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 100.0, 99.0, 99.0, 95.0, 96.0, 100.0, 100.0, 95.0, 95.0], "value": 97.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 60.0, 55.0, 54.0, 55.0, 57.0, 58.0, 55.0, 54.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 63.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 80.0, 82.0, 80.0, 80.0, 79.0, 103.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 124.0, 137.0, 128.0, 122.0, 132.0, 138.0, 135.0, 137.0, 122.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 166.0, 163.0, 164.0, 163.0, 159.0, 161.0, 159.0, 171.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 62.0, 62.0, 63.0, 63.0, 62.0, 64.0], "value": 63.1, "unit": "score"}]}]} 12:14:06 INFO - Return code: 0 12:14:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:14:06 ERROR - # TBPL SUCCESS # 12:14:06 INFO - Running post-action listener: _resource_record_post_action 12:14:06 INFO - ##### 12:14:06 INFO - ##### Finished run-tests step (success) 12:14:06 INFO - ##### 12:14:06 INFO - Running post-run listener: _resource_record_post_run 12:14:06 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539103232; Read time: 16; Write time: 549544 12:14:06 INFO - TinderboxPrint: CPU usage
13.5% 12:14:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 12:14:06 INFO - TinderboxPrint: I/O write bytes / time
539,103,232 / 549,544 12:14:06 INFO - TinderboxPrint: CPU idle
8,220.4 (86.5%) 12:14:06 INFO - TinderboxPrint: CPU user
1,225.8 (12.9%) 12:14:06 INFO - TinderboxPrint: Swap in / out
0 / 0 12:14:06 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247574528; Read time: 0; Write time: 309152 12:14:06 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291528704; Read time: 16; Write time: 240392 12:14:07 INFO - Running post-run listener: _upload_blobber_files 12:14:07 INFO - Blob upload gear active. 12:14:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:14:07 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 12:14:07 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:14:07 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:14:07 INFO - (blobuploader) - INFO - Open directory for files ... 12:14:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:14:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:14:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:14:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:14:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:14:08 INFO - (blobuploader) - INFO - Done attempting. 12:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:14:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:14:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:14:09 INFO - (blobuploader) - INFO - Done attempting. 12:14:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:14:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:14:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:14:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:14:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:14:14 INFO - (blobuploader) - INFO - Done attempting. 12:14:14 INFO - (blobuploader) - INFO - Iteration through files over. 12:14:14 INFO - Return code: 0 12:14:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:14:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:14:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3612b19259e6d99cf45dc45446f50c3ec2f52bdc217d34d6a6a2e32d1978f485721be34c2d401043b868230aa03b47d96353a930f848330e4447d8ea3bc22cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/539f28a6fabd3887178d838fd4606e8e0b46ecf6763fd83a4e68e9798f13f086c9e75fc34a0c6fa316e1243e285b2fe0c69b8d91a3e99af5fbd92c32d4dff0e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bffae9b79d234f35ba4991a84057634eaee660ca26d764d0bb2405a202606951ac7cc20ba75eb4a5645bfdd627ecf9c04d292159c8e5e01d92275a483a6dadbc"} 12:14:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:14:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:14:14 INFO - Contents: 12:14:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3612b19259e6d99cf45dc45446f50c3ec2f52bdc217d34d6a6a2e32d1978f485721be34c2d401043b868230aa03b47d96353a930f848330e4447d8ea3bc22cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/539f28a6fabd3887178d838fd4606e8e0b46ecf6763fd83a4e68e9798f13f086c9e75fc34a0c6fa316e1243e285b2fe0c69b8d91a3e99af5fbd92c32d4dff0e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bffae9b79d234f35ba4991a84057634eaee660ca26d764d0bb2405a202606951ac7cc20ba75eb4a5645bfdd627ecf9c04d292159c8e5e01d92275a483a6dadbc"} 12:14:14 INFO - Running post-run listener: copy_logs_to_upload_dir 12:14:14 INFO - Copying logs to upload dir... 12:14:14 INFO - mkdir: /builds/slave/test/build/upload/logs 12:14:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.805615 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-02 12:14:14.012555) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 12:14:14.017961) ========= 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=7de08804244eb36560b44971000001c3-1464893616.234957-1685311867 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/sha512/c3612b19259e6d99cf45dc45446f50c3ec2f52bdc217d34d6a6a2e32d1978f485721be34c2d401043b868230aa03b47d96353a930f848330e4447d8ea3bc22cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/539f28a6fabd3887178d838fd4606e8e0b46ecf6763fd83a4e68e9798f13f086c9e75fc34a0c6fa316e1243e285b2fe0c69b8d91a3e99af5fbd92c32d4dff0e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bffae9b79d234f35ba4991a84057634eaee660ca26d764d0bb2405a202606951ac7cc20ba75eb4a5645bfdd627ecf9c04d292159c8e5e01d92275a483a6dadbc"} build_url:https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3612b19259e6d99cf45dc45446f50c3ec2f52bdc217d34d6a6a2e32d1978f485721be34c2d401043b868230aa03b47d96353a930f848330e4447d8ea3bc22cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/539f28a6fabd3887178d838fd4606e8e0b46ecf6763fd83a4e68e9798f13f086c9e75fc34a0c6fa316e1243e285b2fe0c69b8d91a3e99af5fbd92c32d4dff0e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bffae9b79d234f35ba4991a84057634eaee660ca26d764d0bb2405a202606951ac7cc20ba75eb4a5645bfdd627ecf9c04d292159c8e5e01d92275a483a6dadbc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 12:14:14.042834) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 12:14:14.043202) ========= 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=7de08804244eb36560b44971000001c3-1464893616.234957-1685311867 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 12:14:14.126459) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 12:14:14.126821) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 12:14:14.127136) ========= ========= Total master_lag: 0.16 =========