builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1461486340.86 results: success (0) buildid: 20160423225058 builduid: e1d4c5cb78d24f88b6389002f64d0523 revision: 08791c3d6f713f4032f704e44bae22353bbdae77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 01:25:40.856116) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 01:25:40.856893) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 01:25:40.857360) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 01:25:40.917325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 01:25:40.917623) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-24 01:25:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 15.7M=0.001s 2016-04-24 01:25:41 (15.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177610 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 01:25:41.109729) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 01:25:41.110006) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018363 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 01:25:41.160043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-24 01:25:41.160587) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 08791c3d6f713f4032f704e44bae22353bbdae77 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 08791c3d6f713f4032f704e44bae22353bbdae77 --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=03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-24 01:25:41,944 truncating revision to first 12 chars 2016-04-24 01:25:41,944 Setting DEBUG logging. 2016-04-24 01:25:41,944 attempt 1/10 2016-04-24 01:25:41,944 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/08791c3d6f71?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-24 01:25:42,785 unpacking tar archive at: mozilla-aurora-08791c3d6f71/testing/mozharness/ program finished with exit code 0 elapsedTime=1.103141 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-24 01:25:42.285671) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 01:25:42.285975) ========= script_repo_revision: 08791c3d6f713f4032f704e44bae22353bbdae77 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 01:25:42.286351) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 01:25:42.286608) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 01:25:42.295874) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-24 01:25:42.296135) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:25:43 INFO - MultiFileLogger online at 20160424 01:25:43 in /builds/slave/test 01:25:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:25:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:25:43 INFO - {'append_to_log': False, 01:25:43 INFO - 'base_work_dir': '/builds/slave/test', 01:25:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:25:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:25:43 INFO - 'branch': 'Mozilla-Aurora', 01:25:43 INFO - 'buildbot_json_path': 'buildprops.json', 01:25:43 INFO - 'config_files': ('talos/linux_config.py',), 01:25:43 INFO - 'default_actions': ('clobber', 01:25:43 INFO - 'read-buildbot-config', 01:25:43 INFO - 'download-and-extract', 01:25:43 INFO - 'populate-webroot', 01:25:43 INFO - 'create-virtualenv', 01:25:43 INFO - 'install', 01:25:43 INFO - 'run-tests'), 01:25:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:25:43 INFO - 'download_minidump_stackwalk': True, 01:25:43 INFO - 'download_symbols': 'ondemand', 01:25:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:25:43 INFO - 'tooltool.py': '/tools/tooltool.py', 01:25:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:25:43 INFO - '/tools/misc-python/virtualenv.py')}, 01:25:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:25:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:25:43 INFO - 'installer_path': 'installer.exe', 01:25:43 INFO - 'log_level': 'info', 01:25:43 INFO - 'log_name': 'talos', 01:25:43 INFO - 'log_to_console': True, 01:25:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:25:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:25:43 INFO - 'opt_config_files': (), 01:25:43 INFO - 'pip_index': False, 01:25:43 INFO - 'sps_profile': False, 01:25:43 INFO - 'sps_profile_interval': 0, 01:25:43 INFO - 'suite': 'dromaeojs-e10s', 01:25:43 INFO - 'system_bits': '32', 01:25:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:25:43 INFO - 'title': 'talos-linux64-ix-047', 01:25:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:25:43 INFO - 'use_talos_json': True, 01:25:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:25:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:25:43 INFO - 'work_dir': 'build'} 01:25:43 INFO - ##### 01:25:43 INFO - ##### Running clobber step. 01:25:43 INFO - ##### 01:25:43 INFO - Running pre-action listener: _resource_record_pre_action 01:25:43 INFO - Running main action method: clobber 01:25:43 INFO - rmtree: /builds/slave/test/build 01:25:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:25:44 INFO - Running post-action listener: _resource_record_post_action 01:25:44 INFO - ##### 01:25:44 INFO - ##### Running read-buildbot-config step. 01:25:44 INFO - ##### 01:25:44 INFO - Running pre-action listener: _resource_record_pre_action 01:25:44 INFO - Running main action method: read_buildbot_config 01:25:44 INFO - Using buildbot properties: 01:25:44 INFO - { 01:25:44 INFO - "project": "", 01:25:44 INFO - "product": "firefox", 01:25:44 INFO - "script_repo_revision": "production", 01:25:44 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 01:25:44 INFO - "repository": "", 01:25:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 01:25:44 INFO - "buildid": "20160423225058", 01:25:44 INFO - "pgo_build": "True", 01:25:44 INFO - "basedir": "/builds/slave/test", 01:25:44 INFO - "buildnumber": 313, 01:25:44 INFO - "slavename": "talos-linux64-ix-047", 01:25:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:25:44 INFO - "platform": "ubuntu64_hw", 01:25:44 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:25:44 INFO - "branch": "mozilla-aurora", 01:25:44 INFO - "repo_path": "releases/mozilla-aurora", 01:25:44 INFO - "revision": "08791c3d6f713f4032f704e44bae22353bbdae77", 01:25:44 INFO - "stage_platform": "linux64-pgo", 01:25:44 INFO - "builduid": "e1d4c5cb78d24f88b6389002f64d0523", 01:25:44 INFO - "slavebuilddir": "test" 01:25:44 INFO - } 01:25:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 01:25:44 INFO - Running post-action listener: _resource_record_post_action 01:25:44 INFO - ##### 01:25:44 INFO - ##### Running download-and-extract step. 01:25:44 INFO - ##### 01:25:44 INFO - Running pre-action listener: _resource_record_pre_action 01:25:44 INFO - Running main action method: download_and_extract 01:25:44 INFO - mkdir: /builds/slave/test/build/tests 01:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:44 INFO - https://queue.taskcluster.net/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:25:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 01:25:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 01:25:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 01:25:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:25:49 INFO - Downloaded 1448 bytes. 01:25:49 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 01:25:49 INFO - Using the following test package requirements: 01:25:49 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 01:25:49 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 01:25:49 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:25:49 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 01:25:49 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 01:25:49 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 01:25:49 INFO - u'jsshell-linux-x86_64.zip'], 01:25:49 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 01:25:49 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:25:49 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 01:25:49 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 01:25:49 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:25:49 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 01:25:49 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:25:49 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 01:25:49 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:25:49 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 01:25:49 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 01:25:49 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:25:49 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:25:49 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')]} 01:25:49 INFO - https://queue.taskcluster.net/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:25:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 01:25:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 01:25:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 01:25:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:25:54 INFO - Downloaded 23358423 bytes. 01:25:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:25:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:25:55 INFO - Return code: 0 01:25:55 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:25:55 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')]} 01:25:55 INFO - https://queue.taskcluster.net/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:25:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 01:25:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 01:25:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 01:25:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:25:56 INFO - Downloaded 23358423 bytes. 01:25:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:25:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:25:58 INFO - Return code: 0 01:25: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')]} 01:25:58 INFO - https://queue.taskcluster.net/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:25:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 01:25:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 01:25:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 01:25:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:25:59 INFO - Downloaded 10845194 bytes. 01:25:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:25:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:25:59 INFO - Return code: 0 01:25:59 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')]} 01:25:59 INFO - https://queue.taskcluster.net/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:25:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 01:25:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 01:25:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 01:25:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:26:00 INFO - Downloaded 60832312 bytes. 01:26:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 01:26:00 INFO - mkdir: /builds/slave/test/properties 01:26:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:26:00 INFO - Writing to file /builds/slave/test/properties/build_url 01:26:00 INFO - Contents: 01:26:00 INFO - build_url:https://queue.taskcluster.net/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 01:26:01 INFO - Running post-action listener: _resource_record_post_action 01:26:01 INFO - Running post-action listener: set_extra_try_arguments 01:26:01 INFO - ##### 01:26:01 INFO - ##### Running populate-webroot step. 01:26:01 INFO - ##### 01:26:01 INFO - Running pre-action listener: _resource_record_pre_action 01:26:01 INFO - Running main action method: populate_webroot 01:26:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:26:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:26:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:26:01 INFO - '--tppagecycles', 01:26:01 INFO - '7'], 01:26:01 INFO - 'tests': ['tsvgm']}}, 01:26:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:26:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:26:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:26:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:26:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:26:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:26:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:26:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:01 INFO - 'talos_options': ['--e10s'], 01:26:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:26:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:01 INFO - 'tests': ['damp', 'tps']}, 01:26:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:01 INFO - 'talos_options': ['--e10s'], 01:26:01 INFO - 'tests': ['damp', 'tps']}, 01:26:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:26:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:26:01 INFO - 'other': {'tests': ['a11yr', 01:26:01 INFO - 'ts_paint', 01:26:01 INFO - 'tpaint', 01:26:01 INFO - 'sessionrestore', 01:26:01 INFO - 'sessionrestore_no_auto_restore', 01:26:01 INFO - 'tabpaint']}, 01:26:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:26:01 INFO - 'tests': ['a11yr', 01:26:01 INFO - 'ts_paint', 01:26:01 INFO - 'tpaint', 01:26:01 INFO - 'sessionrestore', 01:26:01 INFO - 'sessionrestore_no_auto_restore', 01:26:01 INFO - 'tabpaint']}, 01:26:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:26:01 INFO - 'tests': ['a11yr', 01:26:01 INFO - 'ts_paint', 01:26:01 INFO - 'tpaint', 01:26:01 INFO - 'sessionrestore', 01:26:01 INFO - 'sessionrestore_no_auto_restore', 01:26:01 INFO - 'tabpaint']}, 01:26:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:26:01 INFO - 'tests': ['a11yr', 01:26:01 INFO - 'ts_paint', 01:26:01 INFO - 'tpaint', 01:26:01 INFO - 'sessionrestore', 01:26:01 INFO - 'sessionrestore_no_auto_restore', 01:26:01 INFO - 'tabpaint']}, 01:26:01 INFO - 'other_l64': {'tests': ['a11yr', 01:26:01 INFO - 'ts_paint', 01:26:01 INFO - 'tpaint', 01:26:01 INFO - 'sessionrestore', 01:26:01 INFO - 'sessionrestore_no_auto_restore', 01:26:01 INFO - 'tabpaint']}, 01:26:01 INFO - 'other_nol64': {'tests': ['a11yr', 01:26:01 INFO - 'ts_paint', 01:26:01 INFO - 'tpaint', 01:26:01 INFO - 'sessionrestore', 01:26:01 INFO - 'sessionrestore_no_auto_restore', 01:26:01 INFO - 'tabpaint']}, 01:26:01 INFO - 'svgr': {'tests': ['tsvgx', 01:26:01 INFO - 'tsvgr_opacity', 01:26:01 INFO - 'tart', 01:26:01 INFO - 'tscrollx', 01:26:01 INFO - 'cart']}, 01:26:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:26:01 INFO - 'tests': ['tsvgx', 01:26:01 INFO - 'tsvgr_opacity', 01:26:01 INFO - 'tart', 01:26:01 INFO - 'tscrollx', 01:26:01 INFO - 'cart']}, 01:26:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:01 INFO - 'tests': ['tp5o']}, 01:26:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:01 INFO - 'talos_options': ['--e10s'], 01:26:01 INFO - 'tests': ['tp5o']}, 01:26:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:01 INFO - 'talos_options': ['--xperf_path', 01:26:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:26:01 INFO - 'tests': ['tp5n']}, 01:26:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:01 INFO - 'talos_options': ['--e10s', 01:26:01 INFO - '--xperf_path', 01:26:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:26:01 INFO - 'tests': ['tp5n']}}, 01:26:01 INFO - 'talos.zip': {'path': '', 01:26:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:26:01 INFO - Running post-action listener: _resource_record_post_action 01:26:01 INFO - ##### 01:26:01 INFO - ##### Running create-virtualenv step. 01:26:01 INFO - ##### 01:26:01 INFO - Running pre-action listener: _resource_record_pre_action 01:26:01 INFO - Running main action method: create_virtualenv 01:26:01 INFO - Creating virtualenv /builds/slave/test/build/venv 01:26:01 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 01:26:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:26:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:26:01 INFO - Using real prefix '/usr' 01:26:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:26:02 INFO - Installing distribute.............................................................................................................................................................................................done. 01:26:04 INFO - Installing pip.................done. 01:26:04 INFO - Return code: 0 01:26:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:04 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 0x7f36b01e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9160>, '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 0x1cda060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cda4f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', '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 01:26:04 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 01:26:04 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 01:26:04 INFO - Using env: {'DISPLAY': ':0', 01:26:04 INFO - 'HOME': '/home/cltbld', 01:26:04 INFO - 'LANG': 'en_US.UTF-8', 01:26:04 INFO - 'LANGUAGE': 'en_US:en', 01:26:04 INFO - 'LOGNAME': 'cltbld', 01:26:04 INFO - 'MAIL': '/var/mail/cltbld', 01:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:04 INFO - 'MOZ_NO_REMOTE': '1', 01:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:04 INFO - 'NO_EM_RESTART': '1', 01:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:04 INFO - 'PWD': '/builds/slave/test', 01:26:04 INFO - 'SHELL': '/bin/bash', 01:26:04 INFO - 'SHLVL': '1', 01:26:04 INFO - 'TERM': 'linux', 01:26:04 INFO - 'TMOUT': '86400', 01:26:04 INFO - 'USER': 'cltbld', 01:26:04 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', 01:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:04 INFO - '_': '/tools/buildbot/bin/python'} 01:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:04 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 01:26:04 INFO - Cleaning up... 01:26:04 INFO - Return code: 0 01:26:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36b01e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9160>, '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 0x1cda060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cda4f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', '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 01:26:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:26:04 INFO - Using env: {'DISPLAY': ':0', 01:26:04 INFO - 'HOME': '/home/cltbld', 01:26:04 INFO - 'LANG': 'en_US.UTF-8', 01:26:04 INFO - 'LANGUAGE': 'en_US:en', 01:26:04 INFO - 'LOGNAME': 'cltbld', 01:26:04 INFO - 'MAIL': '/var/mail/cltbld', 01:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:04 INFO - 'MOZ_NO_REMOTE': '1', 01:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:04 INFO - 'NO_EM_RESTART': '1', 01:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:04 INFO - 'PWD': '/builds/slave/test', 01:26:04 INFO - 'SHELL': '/bin/bash', 01:26:04 INFO - 'SHLVL': '1', 01:26:04 INFO - 'TERM': 'linux', 01:26:04 INFO - 'TMOUT': '86400', 01:26:04 INFO - 'USER': 'cltbld', 01:26:04 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', 01:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:04 INFO - '_': '/tools/buildbot/bin/python'} 01:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:04 INFO - Downloading/unpacking psutil>=0.7.1 01:26:04 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 01:26:04 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 01:26:04 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 01:26:04 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 01:26:04 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 01:26:04 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 01:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:26:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:06 INFO - Installing collected packages: psutil 01:26:06 INFO - Running setup.py install for psutil 01:26:06 INFO - building 'psutil._psutil_linux' extension 01:26:06 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 01:26:06 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 01:26:06 INFO - building 'psutil._psutil_posix' extension 01:26:06 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 01:26:06 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 01:26:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:06 INFO - Successfully installed psutil 01:26:06 INFO - Cleaning up... 01:26:07 INFO - Return code: 0 01:26:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36b01e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9160>, '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 0x1cda060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cda4f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', '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 01:26:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:26:07 INFO - Using env: {'DISPLAY': ':0', 01:26:07 INFO - 'HOME': '/home/cltbld', 01:26:07 INFO - 'LANG': 'en_US.UTF-8', 01:26:07 INFO - 'LANGUAGE': 'en_US:en', 01:26:07 INFO - 'LOGNAME': 'cltbld', 01:26:07 INFO - 'MAIL': '/var/mail/cltbld', 01:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:07 INFO - 'MOZ_NO_REMOTE': '1', 01:26:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:07 INFO - 'NO_EM_RESTART': '1', 01:26:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:07 INFO - 'PWD': '/builds/slave/test', 01:26:07 INFO - 'SHELL': '/bin/bash', 01:26:07 INFO - 'SHLVL': '1', 01:26:07 INFO - 'TERM': 'linux', 01:26:07 INFO - 'TMOUT': '86400', 01:26:07 INFO - 'USER': 'cltbld', 01:26:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', 01:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:07 INFO - '_': '/tools/buildbot/bin/python'} 01:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:26: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 01:26: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 01:26: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 01:26: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 01:26: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 01:26: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 01:26:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:26:09 INFO - Installing collected packages: mozsystemmonitor 01:26:09 INFO - Running setup.py install for mozsystemmonitor 01:26:09 INFO - Successfully installed mozsystemmonitor 01:26:09 INFO - Cleaning up... 01:26:09 INFO - Return code: 0 01:26:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26: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')]} 01:26:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26: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', '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 0x7f36b01e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9160>, '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 0x1cda060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cda4f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', '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 01:26: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:26: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 blobuploader==1.2.4 01:26:09 INFO - Using env: {'DISPLAY': ':0', 01:26:09 INFO - 'HOME': '/home/cltbld', 01:26:09 INFO - 'LANG': 'en_US.UTF-8', 01:26:09 INFO - 'LANGUAGE': 'en_US:en', 01:26:09 INFO - 'LOGNAME': 'cltbld', 01:26:09 INFO - 'MAIL': '/var/mail/cltbld', 01:26:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:09 INFO - 'MOZ_NO_REMOTE': '1', 01:26:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:09 INFO - 'NO_EM_RESTART': '1', 01:26:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:09 INFO - 'PWD': '/builds/slave/test', 01:26:09 INFO - 'SHELL': '/bin/bash', 01:26:09 INFO - 'SHLVL': '1', 01:26:09 INFO - 'TERM': 'linux', 01:26:09 INFO - 'TMOUT': '86400', 01:26:09 INFO - 'USER': 'cltbld', 01:26:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', 01:26:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:09 INFO - '_': '/tools/buildbot/bin/python'} 01:26:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:09 INFO - Downloading/unpacking blobuploader==1.2.4 01:26: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 01:26: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 01:26: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 01:26: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 01:26: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 01:26: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 01:26:11 INFO - Downloading blobuploader-1.2.4.tar.gz 01:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:26:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:26: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 01:26: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 01:26: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 01:26: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 01:26: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 01:26: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 01:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:26:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:26: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 01:26: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 01:26: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 01:26: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 01:26: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 01:26: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 01:26:12 INFO - Downloading docopt-0.6.1.tar.gz 01:26:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:26:12 INFO - Installing collected packages: blobuploader, requests, docopt 01:26:12 INFO - Running setup.py install for blobuploader 01:26:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:26:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:26:12 INFO - Running setup.py install for requests 01:26:12 INFO - Running setup.py install for docopt 01:26:12 INFO - Successfully installed blobuploader requests docopt 01:26:12 INFO - Cleaning up... 01:26:12 INFO - Return code: 0 01:26:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26: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')]} 01:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26: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')]} 01:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:12 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 0x7f36b01e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9160>, '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 0x1cda060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cda4f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', '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 01:26:12 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 01:26:12 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 01:26:12 INFO - Using env: {'DISPLAY': ':0', 01:26:12 INFO - 'HOME': '/home/cltbld', 01:26:12 INFO - 'LANG': 'en_US.UTF-8', 01:26:12 INFO - 'LANGUAGE': 'en_US:en', 01:26:12 INFO - 'LOGNAME': 'cltbld', 01:26:12 INFO - 'MAIL': '/var/mail/cltbld', 01:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:12 INFO - 'MOZ_NO_REMOTE': '1', 01:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:12 INFO - 'NO_EM_RESTART': '1', 01:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:12 INFO - 'PWD': '/builds/slave/test', 01:26:12 INFO - 'SHELL': '/bin/bash', 01:26:12 INFO - 'SHLVL': '1', 01:26:12 INFO - 'TERM': 'linux', 01:26:12 INFO - 'TMOUT': '86400', 01:26:12 INFO - 'USER': 'cltbld', 01:26:12 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', 01:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:12 INFO - '_': '/tools/buildbot/bin/python'} 01:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:26:12 INFO - Running setup.py (path:/tmp/pip-Jnj_Bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:26:13 INFO - Running setup.py (path:/tmp/pip-JK1sNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:26:13 INFO - Running setup.py (path:/tmp/pip-zvs2QG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:26:13 INFO - Running setup.py (path:/tmp/pip-FbyrtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:26:13 INFO - Running setup.py (path:/tmp/pip-u9SBKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:26:13 INFO - Running setup.py (path:/tmp/pip-lBSQWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:26:13 INFO - Running setup.py (path:/tmp/pip-d1tdAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:26:13 INFO - Running setup.py (path:/tmp/pip-Zw6e7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:26:13 INFO - Running setup.py (path:/tmp/pip-cXplZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:26:13 INFO - Running setup.py (path:/tmp/pip-KPhbx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:26:13 INFO - Running setup.py (path:/tmp/pip-mRAu28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:26:13 INFO - Running setup.py (path:/tmp/pip-ORJlfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:26:13 INFO - Running setup.py (path:/tmp/pip-T5bC1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:26:13 INFO - Running setup.py (path:/tmp/pip-gIhxyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:14 INFO - Running setup.py (path:/tmp/pip-ca9Ind-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:26:14 INFO - Running setup.py (path:/tmp/pip-68VjZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:26:14 INFO - Running setup.py (path:/tmp/pip-J6A51P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:26:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:26:14 INFO - Running setup.py install for manifestparser 01:26:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Running setup.py install for mozcrash 01:26:14 INFO - Running setup.py install for mozdebug 01:26:14 INFO - Running setup.py install for mozdevice 01:26:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Running setup.py install for mozfile 01:26:14 INFO - Running setup.py install for mozhttpd 01:26:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Running setup.py install for mozinfo 01:26:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:26:14 INFO - Running setup.py install for mozInstall 01:26:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Running setup.py install for mozleak 01:26:15 INFO - Running setup.py install for mozlog 01:26:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Running setup.py install for moznetwork 01:26:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Running setup.py install for mozprocess 01:26:15 INFO - Running setup.py install for mozprofile 01:26:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Running setup.py install for mozrunner 01:26:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Running setup.py install for mozscreenshot 01:26:15 INFO - Running setup.py install for moztest 01:26:15 INFO - Running setup.py install for mozversion 01:26:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:26:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:26:15 INFO - Cleaning up... 01:26:16 INFO - Return code: 0 01:26:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:16 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 0x7f36b01e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9160>, '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 0x1cda060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cda4f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', '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 01:26:16 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 01:26:16 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 01:26:16 INFO - Using env: {'DISPLAY': ':0', 01:26:16 INFO - 'HOME': '/home/cltbld', 01:26:16 INFO - 'LANG': 'en_US.UTF-8', 01:26:16 INFO - 'LANGUAGE': 'en_US:en', 01:26:16 INFO - 'LOGNAME': 'cltbld', 01:26:16 INFO - 'MAIL': '/var/mail/cltbld', 01:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:16 INFO - 'MOZ_NO_REMOTE': '1', 01:26:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:16 INFO - 'NO_EM_RESTART': '1', 01:26:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:16 INFO - 'PWD': '/builds/slave/test', 01:26:16 INFO - 'SHELL': '/bin/bash', 01:26:16 INFO - 'SHLVL': '1', 01:26:16 INFO - 'TERM': 'linux', 01:26:16 INFO - 'TMOUT': '86400', 01:26:16 INFO - 'USER': 'cltbld', 01:26:16 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', 01:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:16 INFO - '_': '/tools/buildbot/bin/python'} 01:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:26:16 INFO - Running setup.py (path:/tmp/pip-iMqhgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:26:16 INFO - Running setup.py (path:/tmp/pip-WSDhfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:26:16 INFO - Running setup.py (path:/tmp/pip-om7GBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:26:16 INFO - Running setup.py (path:/tmp/pip-9ZICVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:26:16 INFO - Running setup.py (path:/tmp/pip-Id6STp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:26:16 INFO - Running setup.py (path:/tmp/pip-rkB6TB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:26:16 INFO - Running setup.py (path:/tmp/pip-M8gpHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:26:16 INFO - Running setup.py (path:/tmp/pip-0VWcLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:26:16 INFO - Running setup.py (path:/tmp/pip-GbTAML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:26:16 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)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:26:16 INFO - Running setup.py (path:/tmp/pip-vX6L_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:26:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:26:16 INFO - Running setup.py (path:/tmp/pip-ywJeFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:26:17 INFO - Running setup.py (path:/tmp/pip-n2dZx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:26:17 INFO - Running setup.py (path:/tmp/pip-FGjjFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:26:17 INFO - Running setup.py (path:/tmp/pip-VNZ_Nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:17 INFO - Running setup.py (path:/tmp/pip-r5dV81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:26:17 INFO - Running setup.py (path:/tmp/pip-nPkbDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:26:17 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)) 01:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:26:17 INFO - Running setup.py (path:/tmp/pip-D64BfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:26:17 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)) 01:26:17 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)) 01:26:17 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)) 01:26:17 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)) 01:26:17 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)) 01:26:17 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)) 01:26:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:26:17 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 01:26:17 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 01:26:17 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 01:26:17 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 01:26:17 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 01:26:17 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 01:26:19 INFO - Downloading blessings-1.6.tar.gz 01:26:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:26:19 INFO - Installing collected packages: blessings 01:26:19 INFO - Running setup.py install for blessings 01:26:19 INFO - Successfully installed blessings 01:26:19 INFO - Cleaning up... 01:26:19 INFO - Return code: 0 01:26:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:26:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:26:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:26:19 INFO - Reading from file tmpfile_stdout 01:26:19 INFO - Current package versions: 01:26:19 INFO - argparse == 1.2.1 01:26:19 INFO - blessings == 1.6 01:26:19 INFO - blobuploader == 1.2.4 01:26:19 INFO - docopt == 0.6.1 01:26:19 INFO - manifestparser == 1.1 01:26:19 INFO - mozInstall == 1.12 01:26:19 INFO - mozcrash == 0.17 01:26:19 INFO - mozdebug == 0.1 01:26:19 INFO - mozdevice == 0.48 01:26:19 INFO - mozfile == 1.2 01:26:19 INFO - mozhttpd == 0.7 01:26:19 INFO - mozinfo == 0.9 01:26:19 INFO - mozleak == 0.1 01:26:19 INFO - mozlog == 3.1 01:26:19 INFO - moznetwork == 0.27 01:26:19 INFO - mozprocess == 0.22 01:26:19 INFO - mozprofile == 0.28 01:26:19 INFO - mozrunner == 6.11 01:26:19 INFO - mozscreenshot == 0.1 01:26:19 INFO - mozsystemmonitor == 0.0 01:26:19 INFO - moztest == 0.7 01:26:19 INFO - mozversion == 1.4 01:26:19 INFO - psutil == 3.1.1 01:26:19 INFO - requests == 1.2.3 01:26:19 INFO - wsgiref == 0.1.2 01:26:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:26:19 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')]} 01:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:19 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')]} 01:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:19 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 0x7f36b01e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9160>, '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 0x1cda060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cda4f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', '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 01:26:19 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 01:26:19 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 01:26:19 INFO - Using env: {'DISPLAY': ':0', 01:26:19 INFO - 'HOME': '/home/cltbld', 01:26:19 INFO - 'LANG': 'en_US.UTF-8', 01:26:19 INFO - 'LANGUAGE': 'en_US:en', 01:26:19 INFO - 'LOGNAME': 'cltbld', 01:26:19 INFO - 'MAIL': '/var/mail/cltbld', 01:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:19 INFO - 'MOZ_NO_REMOTE': '1', 01:26:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:19 INFO - 'NO_EM_RESTART': '1', 01:26:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:19 INFO - 'PWD': '/builds/slave/test', 01:26:19 INFO - 'SHELL': '/bin/bash', 01:26:19 INFO - 'SHLVL': '1', 01:26:19 INFO - 'TERM': 'linux', 01:26:19 INFO - 'TMOUT': '86400', 01:26:19 INFO - 'USER': 'cltbld', 01:26:19 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', 01:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:19 INFO - '_': '/tools/buildbot/bin/python'} 01:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:19 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)) 01:26:19 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)) 01:26:19 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)) 01:26:19 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)) 01:26:19 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)) 01:26:19 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)) 01:26:19 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)) 01:26:19 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)) 01:26:19 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)) 01:26:19 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)) 01:26:19 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)) 01:26:19 INFO - Cleaning up... 01:26:20 INFO - Return code: 0 01:26:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36b01e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9160>, '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 0x1cda060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cda4f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', '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 01:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:26:20 INFO - Using env: {'DISPLAY': ':0', 01:26:20 INFO - 'HOME': '/home/cltbld', 01:26:20 INFO - 'LANG': 'en_US.UTF-8', 01:26:20 INFO - 'LANGUAGE': 'en_US:en', 01:26:20 INFO - 'LOGNAME': 'cltbld', 01:26:20 INFO - 'MAIL': '/var/mail/cltbld', 01:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:20 INFO - 'MOZ_NO_REMOTE': '1', 01:26:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:20 INFO - 'NO_EM_RESTART': '1', 01:26:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:20 INFO - 'PWD': '/builds/slave/test', 01:26:20 INFO - 'SHELL': '/bin/bash', 01:26:20 INFO - 'SHLVL': '1', 01:26:20 INFO - 'TERM': 'linux', 01:26:20 INFO - 'TMOUT': '86400', 01:26:20 INFO - 'USER': 'cltbld', 01:26:20 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', 01:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:20 INFO - '_': '/tools/buildbot/bin/python'} 01:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:20 INFO - Downloading/unpacking jsonschema 01:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:26:22 INFO - Downloading/unpacking functools32 (from jsonschema) 01:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:22 INFO - Downloading functools32-3.2.3-2.tar.gz 01:26:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:26:22 INFO - warning: no files found matching '*.txt' 01:26:22 INFO - no previously-included directories found matching 'build' 01:26:22 INFO - no previously-included directories found matching 'dist' 01:26:22 INFO - no previously-included directories found matching '.git*' 01:26:22 INFO - Installing collected packages: jsonschema, functools32 01:26:22 INFO - Running setup.py install for functools32 01:26:22 INFO - warning: no files found matching '*.txt' 01:26:22 INFO - no previously-included directories found matching 'build' 01:26:22 INFO - no previously-included directories found matching 'dist' 01:26:22 INFO - no previously-included directories found matching '.git*' 01:26:22 INFO - Successfully installed jsonschema functools32 01:26:22 INFO - Cleaning up... 01:26:22 INFO - Return code: 0 01:26:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:22 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 0x7f36b01e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9160>, '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 0x1cda060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cda4f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', '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 01:26:22 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 01:26:22 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 01:26:22 INFO - Using env: {'DISPLAY': ':0', 01:26:22 INFO - 'HOME': '/home/cltbld', 01:26:22 INFO - 'LANG': 'en_US.UTF-8', 01:26:22 INFO - 'LANGUAGE': 'en_US:en', 01:26:22 INFO - 'LOGNAME': 'cltbld', 01:26:22 INFO - 'MAIL': '/var/mail/cltbld', 01:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:22 INFO - 'MOZ_NO_REMOTE': '1', 01:26:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:22 INFO - 'NO_EM_RESTART': '1', 01:26:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:22 INFO - 'PWD': '/builds/slave/test', 01:26:22 INFO - 'SHELL': '/bin/bash', 01:26:22 INFO - 'SHLVL': '1', 01:26:22 INFO - 'TERM': 'linux', 01:26:22 INFO - 'TMOUT': '86400', 01:26:22 INFO - 'USER': 'cltbld', 01:26:22 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', 01:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:22 INFO - '_': '/tools/buildbot/bin/python'} 01:26:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:22 INFO - Downloading/unpacking flake8 01:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:26:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:26:24 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 01:26:24 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 01:26:24 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 01:26:24 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 01:26:24 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 01:26:24 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 01:26:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:26:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:26:24 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 01:26:24 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 01:26:24 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 01:26:24 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 01:26:24 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 01:26:24 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 01:26:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:26:25 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 01:26:25 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 01:26:25 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 01:26:25 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 01:26:25 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 01:26:25 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 01:26:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:26:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:26:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:26:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:26:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:26:25 INFO - no previously-included directories found matching 'docs/_build' 01:26:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:26:25 INFO - Running setup.py install for pep8 01:26:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:26:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:26:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:26:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:26:25 INFO - no previously-included directories found matching 'docs/_build' 01:26:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:26:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:26:25 INFO - Cleaning up... 01:26:25 INFO - Return code: 0 01:26:25 INFO - Running post-action listener: _resource_record_post_action 01:26:25 INFO - Running post-action listener: _start_resource_monitoring 01:26:25 INFO - Starting resource monitoring. 01:26:25 INFO - ##### 01:26:25 INFO - ##### Running install step. 01:26:25 INFO - ##### 01:26:25 INFO - Running pre-action listener: _resource_record_pre_action 01:26:25 INFO - Running main action method: install 01:26:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:26:25 INFO - Reading from file tmpfile_stdout 01:26:25 INFO - Detecting whether we're running mozinstall >=1.0... 01:26:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:26:25 INFO - Reading from file tmpfile_stdout 01:26:25 INFO - Output received: 01:26:25 INFO - Usage: mozinstall [options] installer 01:26:25 INFO - Options: 01:26:25 INFO - -h, --help show this help message and exit 01:26:25 INFO - -d DEST, --destination=DEST 01:26:25 INFO - Directory to install application into. [default: 01:26:25 INFO - "/builds/slave/test"] 01:26:25 INFO - --app=APP Application being installed. [default: firefox] 01:26:25 INFO - mkdir: /builds/slave/test/build/application 01:26:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:26:41 INFO - Reading from file tmpfile_stdout 01:26:41 INFO - Output received: 01:26:41 INFO - /builds/slave/test/build/application/firefox/firefox 01:26:41 INFO - Running post-action listener: _resource_record_post_action 01:26:41 INFO - ##### 01:26:41 INFO - ##### Running run-tests step. 01:26:41 INFO - ##### 01:26:41 INFO - Running pre-action listener: _resource_record_pre_action 01:26:41 INFO - Running main action method: run_tests 01:26:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:26:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:26:41 INFO - Python 2.7.3 01:26:41 INFO - Return code: 0 01:26:41 INFO - grabbing minidump binary from tooltool 01:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:41 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9160>, '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 0x1cda060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cda4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:26:41 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 01:26:41 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 01:26:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:26:41 INFO - Return code: 0 01:26:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:26:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:26:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:26:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:26:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:26:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:26:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:26:42 INFO - Return code: 0 01:26:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 01:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 01:26:42 INFO - Using env: {'DISPLAY': ':0', 01:26:42 INFO - 'HOME': '/home/cltbld', 01:26:42 INFO - 'LANG': 'en_US.UTF-8', 01:26:42 INFO - 'LANGUAGE': 'en_US:en', 01:26:42 INFO - 'LOGNAME': 'cltbld', 01:26:42 INFO - 'MAIL': '/var/mail/cltbld', 01:26:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:26:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:42 INFO - 'MOZ_NO_REMOTE': '1', 01:26:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:26:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:42 INFO - 'NO_EM_RESTART': '1', 01:26:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:26:42 INFO - 'PWD': '/builds/slave/test', 01:26:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:26:42 INFO - 'SHELL': '/bin/bash', 01:26:42 INFO - 'SHLVL': '1', 01:26:42 INFO - 'TERM': 'linux', 01:26:42 INFO - 'TMOUT': '86400', 01:26:42 INFO - 'USER': 'cltbld', 01:26:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556', 01:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:42 INFO - '_': '/tools/buildbot/bin/python'} 01:26:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 01:26:42 INFO - mozversion application_buildid: 20160423225058 01:26:42 INFO - mozversion application_changeset: 08791c3d6f713f4032f704e44bae22353bbdae77 01:26:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:26:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:26:42 INFO - mozversion application_name: Firefox 01:26:42 INFO - mozversion application_remotingname: firefox-dev 01:26:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:26:42 INFO - mozversion application_vendor: Mozilla 01:26:42 INFO - mozversion application_version: 47.0a2 01:26:42 INFO - mozversion platform_buildid: 20160423225058 01:26:42 INFO - mozversion platform_changeset: 08791c3d6f713f4032f704e44bae22353bbdae77 01:26:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:26:42 INFO - mozversion platform_version: 47.0a2 01:26:42 INFO - using testdate: 1461486402 01:26:42 INFO - actual date: 1461486402 01:26:42 INFO - starting webserver on 'localhost:49129' 01:26:42 INFO - SUITE-START | Running 2 tests 01:26:42 INFO - TEST-START | dromaeo_css 01:26:42 INFO - operating with platform_type : linux_ 01:26:42 INFO - Initialising browser for dromaeo_css test... 01:26:42 INFO - TEST-INFO | started process 16653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXMYl8p/profile http://localhost:49129/getInfo.html) 01:26:46 INFO - PROCESS | 16653 | 01:26:46 INFO - PROCESS | 16653 | (process:16732): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:26:47 INFO - PROCESS | 16653 | __metrics Screen width/height:1600/1200 01:26:47 INFO - PROCESS | 16653 | colorDepth:24 01:26:47 INFO - PROCESS | 16653 | Browser inner width/height: 1024/697 01:26:47 INFO - PROCESS | 16653 | __metrics 01:26:47 ERROR - PROCESS | 16653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 01:26:48 INFO - TEST-INFO | 16653: exit 0 01:26:48 INFO - Browser initialized. 01:26:48 INFO - Running cycle 1/1 for dromaeo_css test... 01:26:48 INFO - TEST-INFO | started process 16783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXMYl8p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:26:50 INFO - PROCESS | 16783 | 01:26:50 INFO - PROCESS | 16783 | (process:16848): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:27:00 INFO - PROCESS | 16783 | RSS: Main: 151482368 01:27:00 INFO - PROCESS | 16783 | 01:27:50 INFO - PROCESS | 16783 | 1461486470015 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] 01:29:57 INFO - PROCESS | 16783 | Cycle 1(1): loaded http://localhost:49129/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49129/tests/dromaeo/cssquery-ext.html) 01:29:58 INFO - PROCESS | 16783 | RSS: Main: 155799552 01:29:58 INFO - PROCESS | 16783 | 01:33:00 INFO - PROCESS | 16783 | Cycle 1(1): loaded http://localhost:49129/tests/dromaeo/cssquery-ext.html (next: http://localhost:49129/tests/dromaeo/cssquery-jquery.html) 01:33:01 INFO - PROCESS | 16783 | RSS: Main: 153669632 01:33:01 INFO - PROCESS | 16783 | 01:36:03 INFO - PROCESS | 16783 | Cycle 1(1): loaded http://localhost:49129/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49129/tests/dromaeo/cssquery-mootools.html) 01:36:03 INFO - PROCESS | 16783 | RSS: Main: 153051136 01:36:03 INFO - PROCESS | 16783 | 01:39:05 INFO - PROCESS | 16783 | Cycle 1(1): loaded http://localhost:49129/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49129/tests/dromaeo/cssquery-prototype.html) 01:39:05 INFO - PROCESS | 16783 | RSS: Main: 152813568 01:39:05 INFO - PROCESS | 16783 | 01:42:08 INFO - PROCESS | 16783 | Cycle 1(1): loaded http://localhost:49129/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49129/tests/dromaeo/cssquery-yui.html) 01:42:08 INFO - PROCESS | 16783 | RSS: Main: 154083328 01:42:08 INFO - PROCESS | 16783 | 01:45:10 INFO - PROCESS | 16783 | Cycle 1(1): loaded http://localhost:49129/tests/dromaeo/cssquery-yui.html (next: http://localhost:49129/tests/dromaeo/cssquery-dojo.html) 01:45:10 INFO - PROCESS | 16783 | RSS: Main: 155328512 01:45:10 INFO - PROCESS | 16783 | 01:45:10 INFO - PROCESS | 16783 | __start_tp_report 01:45:10 INFO - PROCESS | 16783 | _x_x_mozilla_page_load 01:45:10 INFO - PROCESS | 16783 | _x_x_mozilla_page_load_details 01:45:10 INFO - PROCESS | 16783 | |i|pagename|runs| 01:45:10 INFO - PROCESS | 16783 | |0;dojo.html;3306.2726200235948;3338.2488939988507;3340.498925161224;3357.4963755436684;3376.898693039208;5421.647592906464;5469.644473109245;5485.561155107592;5510.393856675762;5522.861928451791;5533.861653458665;5543.695096769676;5552.333719953611;5552.583556233279;5557.972210138953;5021.874453138674;5078.4159821620615;5079.517445842639;5138.974305128488;5161.458046905077;5070.771815268304;5078.898422031557;5094.235864620318;5121.12940800063;5126.436092029874;5034.697918124924;5089;5096.643234973553;5098.184290513518;5179.352580927384;5116.334876466073;5158.12311906973;5168;5180.456052114511;5203.323567936182;4965.975170124162;4987.675801072919;5010.473900240495;5062.0888240116765;5068.797248110071;5276.182191760283;5298.92051619226;5313.57491400687;5316.813911513117;5347.759350829222;5865.237519122486;5872.265966754156;5878.41215878413;5879.470847623735;5892.882142357129;5801.53587712982;5826.679532625704;5866.589338746289;5892.558058145613;5930.110483427477;5549.361823390281;5588.720563971785;5624.859378515529;5624.971875140598;5630.239917611152;5961.374055724174;6058.787942421994;6089.208402907594;6102.847428814315;6105.511559075263;5888.175655408247;5950.137230101697;5956.106584012433;5961.821145365646;5963.761449541969;6041.365656605993;6062.090686397076;6063.696815159225;6068.969655151696;6082.513398928075;5668.376478587352;5947.464728174398;6005.189299444606;6005.789797357159;6011.038233882645;5994;5999.430054144849;6007.609505382136;6026;6052.757889684452;4542.318652202196;4549.135664223787;4556.2937744649635;4563.110193512233;4582.152301824173;4005.4792876925812;4038.8586399475876;4073.6130067643526;4104.651104656078;4125.216208920296;5463.453654634504;5673.404292549306;5695.7152142392715;5698.6580805151;5766.942330576724;5867.823965281048;5885.499732522698;5892;5933.110033494924;5934.673592952343;5560.165975103767;5578.860528486739;5590.944090559043;5603.551715862721;5659.405762394971;5047.041062198171;5070.3155074064525;5100.6429549931145;5123.257127716461;5151.5878729701535;5987.940120598738;6036.034234522544;6040.758369665252;6062.302835174011;6062.969685151635;5880.647161170344;5898.970505147447;5902.6458412495385;5903.203067585821;5924.052151655801;6036.63780173191;6114.084479019511;6115.727150604437;6129.5150668530305;6136.365905528278;5950.3454619992635;5957.851053723518;5965.9105113422465;5970.611910225822;5973.761049557969;5815.273090863642;6016.7292471838;6018.909716354171;6036.456718895321;6068.544859135671;5884.9705751470965;5886.3525012247765;5900.468957793648;5919.141724450017;5945.227120474311;5899.67551784656;5900.70496475166;5910.497607703393;5912.349641539513;5912.73392697321;5718.228039214653;5740.598158128891;5787.392323806108;5790.855228619318;5824.097264923944;5720.399358067343;5820.330661973927;5831.766729330949;5836.533077353716;5870.031444811559;5697.059985102577;5701.116326969326;5712.885742285048;5716.79991200306;5747.9137812932 01:45:10 INFO - PROCESS | 16783 | |1;ext.html;551.2558046637039;563.7547666764955;570.940051294614;585.3531847308724;645.3546453546453;38552.614473855254;39063.80468097656;39145;39216.60783392169;39310.410343844866;42926.78536607321;43474.13051738963;43490.78254608723;43565;43660.56339436604;8841.160089791476;8920.241779448756;8932.64269429222;8959.686410975584;9064.18422341989;8877.334199934998;8985.77535561613;9015.233705135071;9024.18782309592;9046.276297896185;9192.632294708237;9215.861762073575;9234.722958311262;9295.58169882357;9323;9158.450492970409;9263.907360926405;9274.860877086849;9290.117438843366;9303.976562578111;9079;9193.816123677556;9200.309976751703;9207.67773127944;9216.49309287989;42825;43181.704548863585;43199.56800432019;43237.56762432367;43371.34942975858;3558.822058897045;3629;3668.761530500509;3746.606606306353;3751.6623503884507;29416.558751618744;29465;29567.40865182684;30169;30228;4372.628326592244;4375.453068366454;4384.21084204843;4429.756363400012;4457.442819647544;287136;288769;290013;291850;292169;45826.08347833091;45909.540904590525;68114;69075;69228.30771692218;44017.119657606665;44166;44240;44328.335074973904;44330.55669443329;15600.375984960701;15716.057036577842;15765.527034188992;15774.68450630981;15817.762733559006;12444.440000200013;12469.501219951282;12488.313142777053;12570.434330455151;12607.369631518388;15043.623909402353;15618.609534761721;15642.374305027672;15702.607434814221;15827.52517424479;6131.210299313801;6153.661548614869;6210.099535567408;6221.5333849961435;6347.619142851444;1015.426284149468;1065.9147268218524;1095.9726006849733;1125.5666568371237;1157.9131565132648;28904.85547572249;29369.265768355534;29520.409591808475;29597.408051838844;32620.18449538733;1143.188336281233;1144.4964215745047;1144.9828252576217;1153.7481832212143;1206.4872429217548;15133;15317.770233446507;15411.691766164615;15448.304826282843;15807.972481788647;315478;549413;550227;554663;827115;58139;58783.11825322624;58993.705031474565;59053.70473147693;59196;1510.8489151084805;1528.4803166923077;1534.0795522686522;1553.0914415067311;1559.391837183522;29288.41423171482;30207.244818879703;30280;30489.23776905595;30656.08031759051;50964.49035509597;51122.233166503276;51366.74316628393;51367.48632513777;51424.48575514197;303730;304052;305974;306211;306263;35155.824220878734;35392.29215415626;35557.64442355543;35662.82168589244;35796.284074318886;47423.76288118537;47914;51297.487025130766;52446.475535245685;52847.207291889885;36032.27935441329;37980;40429.595704042586;40498.59501404948;41002.79498602488;39558.80220598879;40431.3935290965;41087.178256435305;41430;41620;38131.42802857904;38947;39019.804900975316;39373.637581745184;39489.2102157961;34697.1325716849;35230.47154292637;35252.294954101286;35363;35432.29135417226;26832.8658356707;27539.862300688368;27543.31141721473;27590.172294831187;27797.58303625407 01:45:10 INFO - PROCESS | 16783 | |2;jquery.html;361.34957077260924;371.57640290069327;372.60317761583894;373.2218324792807;373.9326921154193;18216.362427315045;18916.337928172517;20235.089420976055;20339.59320813583;20377;18611.441656750285;18883.433496995112;18942.337018204365;19150;19202.711959320623;5312.893742125155;5589.888202235943;5607.635503692268;5639.746211420496;5640.576956728241;5172.405173405069;5366.865828354284;5384.865378365533;5408.3509978802595;5418.29562156919;5295.338082739658;5347.946520534803;5361.490658387447;6117.785877494289;6189.071639254125;6059.939400605982;6065.211522502069;6068.453839154476;6070.362611925729;6096.4513193812545;4996.600271978233;5168.9741551292;5208.2968799212;5456.454354564551;5472.890542189174;13703.90368770496;13731.313434328244;13753.312334383341;16530.917345413316;20868.5826283475;2235.284708893155;2326.1160758911674;2369;2407.5546023985617;2519.9794083396255;9610.231181505464;9630.47032413217;9724.562394692184;9774.26692998028;9898.604055837757;1782.064416181515;1850.3523766681553;1864.3567969050655;1902.533879199605;1933.1880610143774;66424;67127.66436167837;67252;67922.98115528272;68447;10292.794144117075;10570.418626975435;10577.682669519927;10722.78554428907;10775;14797;14884.553463396116;14992.175430351435;14996.100233985995;15013.774793378108;7717.729879454305;7750.457467977188;7780.949571807733;7800.180980997027;7978.6409611567615;7105.218425973138;7251.782446526613;7276.126864776261;7312.707491700379;7541.208173141741;4613.65397595175;4706.058788242365;4759.38128043359;4789.30555069513;4864.148773964542;1902.942911712623;1938.806119388078;1940.553672655297;2021.6057868715754;2063.546019875625;911.1799380557551;983.2625530851861;988.945607991553;1062.824633935392;1093.4150229627112;17365;17792.110394480223;17941.7308740369;18052.18765155545;18512;981.906718861707;1005.7586179317058;1012.6658202793061;1039.142707266508;1067.386252904583;9973.650922217688;10434.739131521621;10443.530041148166;10509.84235236472;10554.947225263979;457398;457589;469099;471377;472642;76265.61867190628;76284.61857690677;79767.20232797714;80116;80273.59863200647;1033.4161198922584;1048.6853943816825;1058.571278632155;1068.930519516229;1069.6897899609025;15688.607784805472;15890.841091588936;15977.840221597635;15986.920065399598;16104.194790260675;26192.73807261903;33931.3213735719;34374.484382733775;34785.65214347925;34835.65164348324;49543.44272100146;49546.50453495563;49637.75181124071;49727.502724972284;50040.749796250784;8543.145685431407;8554.230119289294;8590.828183436171;8601.827963440572;8626;12133.939330303292;12817.807732883828;12859.678508037;12993.4152963115;13108;11223.326600404002;11371.54513819438;11383.373914434454;11450.885491145315;11557.537698491966;11810.704732381759;11871.881281187423;11955.76088478243;11995.700107497383;12032.157748957488;11700.35648039332;11927.940360298144;12106.065528703382;12367.876321237032;12502.749945001231;8574.442661227;8698.21716045559;8736.25741811953;8827.955860220658;8832.205101540892;11271.323720576464;11683.240589361665;11763.823542647038;11896.583619573274;11999.700007499534 01:45:10 INFO - PROCESS | 16783 | |3;mootools.html;1502.8271748748894;1540.591743188055;1773.5211492896917;1867.9813201867978;1917.2810196176433;7254.782356529299;7724.304812566867;7933.722319718811;8046.758597242085;8147.470414423065;7968.083670377909;8008.559529225905;8088.514689118657;8100.270975612194;8104.230098140682;2381.3808409813487;2414.4446777241246;2416.3113512648897;2417.830751847371;2419.52819200256;2383.8212134090013;2405.494846082316;2439.9878000609974;2440.8779561021965;2448.608222684371;2410.276916924924;2410.674558934548;2425.805935525154;2455;2459.5449841779237;2422.0917156066475;2436.8537887726707;2443.450223699671;2443.596806526921;2452.9632055519182;2355.0108954239263;2365.7042869641296;2369.988150059256;2370.798482129021;2377.702787151606;8206.302464290542;8222.424430289882;8227.753167404988;8265.95867020661;8304.294134998532;4985;5122.078025955327;5126.846194614168;5134.332536770234;5139.61452891031;3123.6407813101555;3140.4661207594763;3183.554302397666;3184.028871194285;3217.0992122205585;1018.9745256368576;1027.5273374247781;1062.2351906627216;1071.1002757683584;1082.258652822819;11423.828642570368;11440.542378304857;11456.255343402652;11466.770664586746;11538.596149134824;4370.759608221515;4477.686561940698;4505.797239124247;4512.278035514302;4535.251683472256;9053.77365565866;9058.365914386062;9095.045020272908;9099.499527525917;9118.133777291147;5011.323471331397;5020.297158397827;5034.421041580192;5050.570701490341;5063.721495317719;4045.9797701011894;4459.152760975404;4524.366588677588;4574.771261436915;4662.184117779375;3673.228621989412;3721.5906250312446;3722.2555488901785;3744.5693745219105;3754.755940863835;1097.1771171621283;1101.6309536305428;1107.5791199344199;1108.6563165418745;1111.7609713911386;979.5983646704817;998.6305067125065;1002.2433063037506;1157.7568710570706;1403.3474434388058;7646.197149299243;7892.171322011221;7895.644695988694;7947.125816160218;7951.761447156595;1153.1581945180067;1160.721426857565;1171.1158075652997;1193.236328749601;1232.550119206501;6059.878802423927;6089.786857459968;6105.542084343692;6113.38866113394;6116.816495505142;9638.710838674851;9941;10024.248181386425;10032.197424206046;10069.446180459998;9195.126462986005;9852.408855468695;9861.457619830979;9872.35829671069;9896.55465504054;7818.569978651115;7842.686292548348;7909.406794490321;7912.4856884302335;7984.800379990431;7337.816554586178;7582.54504729718;7633.351165151024;7715;7763.456558041109;8594.441361311494;8714.215720585178;8802.779930501789;8926.464412135292;8929.73210803677;8776;8955.41789783662;9091.59087841062;9130.315226358183;9173.174414302744;6343.175387199634;6864.141982252218;7015.859682806417;7049.6122713249215;7167.104111986002;7701.6534255957495;7752;7775.650095745592;7810.687572497037;7840.098388685375;7033.542819716702;7144.785656430316;7157.964210178916;7214.170370407261;7301.926980730124;6829.931700683128;6839.555428897106;6900.7929762107215;6940.236573976757;7008.159020917318;7517.398608111229;7553.206913274027;7612.733554325572;7648.273414025659;7662.655180517002;6766.966165169143;6830.59016459014;6833.794986150423;6872.965635171792;6909.689063992233;6727.562708424132;6766.560173588701;6781.2879647638265;6852.417544508772;6886.070380498569 01:45:10 INFO - PROCESS | 16783 | |4;prototype.html;363.80718219343726;364.27327481674064;367.44332336510183;367.7425801938643;375.79143575315703;6390.424861762441;6430.485561155108;6431.163948686664;6452.935470645298;6466.515011374142;6333.050042493628;6346.714397852096;6358.9825627899545;6372.076048972896;6388.48892088633;4664;4731.692439991407;4763.595094416979;4765.380500534926;4842.709437433748;4763.642726795487;4778.474367819537;4781.8087276508895;4799.18413869643;4803.975980120112;4733.337332773414;4752.85741427756;4753.096911586787;4761.047790441909;4763.928541071887;4709.387779588666;4741.099191153687;4764.999999999965;4770.117528257283;4776.09254241693;4140.523839758406;4156.8129434175235;4158.147579746144;4164.292070348048;4167.395727619509;5995.52035837132;6000.789972350947;6020.217371741645;6055.515558755289;6071.574989750719;5376.758045887945;5497.642653227527;5546.389897111315;5560.499555040025;5589.7205139743255;6717.966410167918;6719.563228390139;6723.562968407086;6755.493337999621;6764.086848275469;4606.930896036529;4607.470140933769;4611.83858564952;4620.699654522446;4632.652551058684;7037.120359955005;7082.504224704273;7091.468139889581;7106.964465177641;7123.145222573273;4450.06548624786;4725.078609671081;4725.763711814396;4728.361671174347;4733.834315798999;4623.3758442609815;4633.513481084505;4647.86056418308;4667.766611669403;4672.766361681903;5454.59090568209;5464.7814087436855;5470.261514695545;5480.232767412565;5483.506484416422;6828.863422731518;6843.0077638742105;6852.5203235773015;6854.177498700088;6875;1672.180631490561;1695.9576010599833;1702.9574260643583;1703.9062851543035;1705.0451747021707;1057.677408390433;1071.7159952612565;1107.76736885255;1108.8170451875512;1118.4854966715238;6537.378948999837;6547.148870646785;6552.475801935833;6564.606123632598;6565.573237739532;7000.264972177848;7007.649617519103;7028.437724981989;7037.049998250171;7046.894296585555;6389.169407976933;6492.058651495507;6562.77030303937;6627.436667883284;6627.5029372797235;3773.4905787718853;3854.8650797221962;3857.9228415431535;3860.6718428933295;3863.092173339263;7224.4581656375985;7317.780466586011;7380.483366164424;7394.260573942563;7396.149442814145;7268.0914885639295;7284.307990740871;7307.451941104438;7359.1169059713175;7384.889226661604;7076.25699301566;7365.926340736632;7376.299251571092;7398.741044063539;7401.296876796696;7100.609466479394;7107.857842843011;7109.040279562193;7115.53749006313;7153.105861767279;7027.9297207027275;7040.929590704028;7049;7058.082449281561;7062.4703147263135;7296.817579560554;7311.488195826241;7358.11702595692;7360.116785985716;7388.298111679382;4598.931016034695;4648.86053418398;4714.528547145395;4726.432828060655;4744.383230180192;7038.331358520933;7074.646267686698;7083.327083927019;7086.185088714864;7090.149182098181;6855.211650660238;6855.417289530246;6868.896966545606;6878.449724021966;6888.276730943379;6825.317468253135;6876;6887.690053947685;6891.035255064195;6898.413634841095;6564.179477565304;6728.932710672831;6786.898196526958;6817.181938167253;6832.180138383425;6920.896186557105;6944.722211111499;6958.269381714847;6960.199577048502;6980.685869136003;6749.460043196631;6781.050652908498;6802.421794147553;6804;6804.965975170093 01:45:10 INFO - PROCESS | 16783 | |5;yui.html;753.8869169624555;800.2477670989273;827.5572568675758;828.3166387730122;829.4525613095351;16590.834091659093;16934.40729574465;16951.237194326255;16954;17027;15474.381024759025;15672.921635391807;15763.92118039411;15776.053436793773;15809.893307468481;900.9504477253765;923.0308176414771;940.8635747816562;943.4339396362162;946.7775072857872;939.0797018921461;940.9153176214139;941.1294552538908;943.6791490893095;944.2729098594078;971.6842026341432;972.4505654305295;972.6692924405701;974.585801034561;976.9316147869652;959.4674955399751;962.0379620379621;964.5804075227263;964.9469279189642;973.9220862331032;708.9149302083783;714.1786945013224;715.7316006497564;716.3517017099481;717.3722992381666;14920.850791492056;14940.178290194035;14967.326470308863;15019.399224031025;15043.548693539211;13904;14066.578002659937;14193;14319.212443315613;14336.64158396038;11064.778704425948;11116.777664446667;11168.720781980515;11192.216544841864;11231.21381503295;3600.2979419013304;3647.5805282392334;3650.5984341722387;3670.963290367089;3726.720495962814;52266;52440;52927.20609190865;53170;53362.466375336524;10666.093382062612;11024.32983100949;11146.386948717736;11261.099112071015;11310.830337544943;20710;20813.271535496184;20857.269995550385;20861.791382085983;20921.47696307574;8015.078265999368;8048.5170889746805;8122.634481448349;8276.627551760184;8420.452670576393;4197;4512.075024619945;4598.356230127785;4634.119517291771;4751.3348131261655;3398.575178102737;3406.693397594179;3429.2455659754814;3434.8110853902776;3436.536067630838;621.1955517604713;625.3465128940269;682.5256446769547;683.7025893736142;697.6337422853043;575.9539236861041;602.5962605054624;661.9702113404908;674.7672053141658;684.0320945861649;7855.214478552099;8082.353411727047;8405.07544170153;8424.452410593292;8545.487270763773;520.88800907805;524.2817340243814;570.3327107284487;640.2573015302227;654.7282877605741;3749.362608356586;3852.1494094370523;3921.5882332355263;3948.842280292126;3980.144268982183;55660;56352.436475635535;56969;57777;57972;52463.47536524586;52671.20993185105;52898;53600.19599706007;53919;47067.293990590166;48528.5147148531;48836;49722.75138624356;49748;7642.4650274480255;7649.655765490677;7808.180141085104;7872.330851877655;8159.306458951056;36180.63819361773;36568.45147322739;36597.26805463929;36923.630763693094;37314.25371492609;42567.57432425636;44369;45596;45956.540434596565;46189.53810461852;11020.889791102307;11404.94297528507;11625.59310424131;11736.823947640964;11817.409129543661;12205.450754716237;12324.691882702646;12408.069394795246;12515;12579.371031448209;10716.142708583138;10734.248602597743;10831.350118992885;10854.29447085937;11017.504212310625;11030.172737044593;11247.100231981585;11475.311481311148;11585.7103572408;11591.304521728724;10302.845457317997;10366.740831479274;10415.270931034755;10467.842982355118;10513.737156570842;9603;9610.567524461556;9628.71113866585;9875.604975800887;9995.250356223458;9260.722178334661;9428.811423771624;9485.33602647808;9511.571979261089;9566.473843938371 01:45:10 INFO - PROCESS | 16783 | __end_tp_report 01:45:10 INFO - PROCESS | 16783 | __start_cc_report 01:45:10 INFO - PROCESS | 16783 | _x_x_mozilla_cycle_collect,353 01:45:10 INFO - PROCESS | 16783 | __end_cc_report 01:45:10 INFO - PROCESS | 16783 | __startTimestamp1461487510982__endTimestamp 01:45:10 INFO - PROCESS | 16783 | 01:45:10 INFO - PROCESS | 16783 | ------- Summary: start ------- 01:45:10 INFO - PROCESS | 16783 | Number of tests: 6 01:45:10 INFO - PROCESS | 16783 | 01:45:10 INFO - PROCESS | 16783 | [#0] dojo.html Cycles:165 Average:5531.18 Median:5747.91 stddev:610.73 (10.6%) stddev-sans-first:587.13 01:45:10 INFO - PROCESS | 16783 | Values: 3306.3 3338.2 3340.5 3357.5 3376.9 5421.6 5469.6 5485.6 5510.4 5522.9 5533.9 5543.7 5552.3 5552.6 5558.0 5021.9 5078.4 5079.5 5139.0 5161.5 5070.8 5078.9 5094.2 5121.1 5126.4 5034.7 5089.0 5096.6 5098.2 5179.4 5116.3 5158.1 5168.0 5180.5 5203.3 4966.0 4987.7 5010.5 5062.1 5068.8 5276.2 5298.9 5313.6 5316.8 5347.8 5865.2 5872.3 5878.4 5879.5 5892.9 5801.5 5826.7 5866.6 5892.6 5930.1 5549.4 5588.7 5624.9 5625.0 5630.2 5961.4 6058.8 6089.2 6102.8 6105.5 5888.2 5950.1 5956.1 5961.8 5963.8 6041.4 6062.1 6063.7 6069.0 6082.5 5668.4 5947.5 6005.2 6005.8 6011.0 5994.0 5999.4 6007.6 6026.0 6052.8 4542.3 4549.1 4556.3 4563.1 4582.2 4005.5 4038.9 4073.6 4104.7 4125.2 5463.5 5673.4 5695.7 5698.7 5766.9 5867.8 5885.5 5892.0 5933.1 5934.7 5560.2 5578.9 5590.9 5603.6 5659.4 5047.0 5070.3 5100.6 5123.3 5151.6 5987.9 6036.0 6040.8 6062.3 6063.0 5880.6 5899.0 5902.6 5903.2 5924.1 6036.6 6114.1 6115.7 6129.5 6136.4 5950.3 5957.9 5965.9 5970.6 5973.8 5815.3 6016.7 6018.9 6036.5 6068.5 5885.0 5886.4 5900.5 5919.1 5945.2 5899.7 5900.7 5910.5 5912.3 5912.7 5718.2 5740.6 5787.4 5790.9 5824.1 5720.4 5820.3 5831.8 5836.5 5870.0 5697.1 5701.1 5712.9 5716.8 5747.9 01:45:10 INFO - PROCESS | 16783 | 01:45:10 INFO - PROCESS | 16783 | [#1] ext.html Cycles:180 Average:54867.41 Median:39342.02 stddev:110822.16 (281.7%) stddev-sans-first:111058.01 01:45:10 INFO - PROCESS | 16783 | Values: 551.3 563.8 570.9 585.4 645.4 38552.6 39063.8 39145.0 39216.6 39310.4 42926.8 43474.1 43490.8 43565.0 43660.6 8841.2 8920.2 8932.6 8959.7 9064.2 8877.3 8985.8 9015.2 9024.2 9046.3 9192.6 9215.9 9234.7 9295.6 9323.0 9158.5 9263.9 9274.9 9290.1 9304.0 9079.0 9193.8 9200.3 9207.7 9216.5 42825.0 43181.7 43199.6 43237.6 43371.3 3558.8 3629.0 3668.8 3746.6 3751.7 29416.6 29465.0 29567.4 30169.0 30228.0 4372.6 4375.5 4384.2 4429.8 4457.4 287136.0 288769.0 290013.0 291850.0 292169.0 45826.1 45909.5 68114.0 69075.0 69228.3 44017.1 44166.0 44240.0 44328.3 44330.6 15600.4 15716.1 15765.5 15774.7 15817.8 12444.4 12469.5 12488.3 12570.4 12607.4 15043.6 15618.6 15642.4 15702.6 15827.5 6131.2 6153.7 6210.1 6221.5 6347.6 1015.4 1065.9 1096.0 1125.6 1157.9 28904.9 29369.3 29520.4 29597.4 32620.2 1143.2 1144.5 1145.0 1153.7 1206.5 15133.0 15317.8 15411.7 15448.3 15808.0 315478.0 549413.0 550227.0 554663.0 827115.0 58139.0 58783.1 58993.7 59053.7 59196.0 1510.8 1528.5 1534.1 1553.1 1559.4 29288.4 30207.2 30280.0 30489.2 30656.1 50964.5 51122.2 51366.7 51367.5 51424.5 303730.0 304052.0 305974.0 306211.0 306263.0 35155.8 35392.3 35557.6 35662.8 35796.3 47423.8 47914.0 51297.5 52446.5 52847.2 36032.3 37980.0 40429.6 40498.6 41002.8 39558.8 40431.4 41087.2 41430.0 41620.0 38131.4 38947.0 39019.8 39373.6 39489.2 34697.1 35230.5 35252.3 35363.0 35432.3 26832.9 27539.9 27543.3 27590.2 27797.6 01:45:10 INFO - PROCESS | 16783 | 01:45:10 INFO - PROCESS | 16783 | [#2] jquery.html Cycles:180 Average:26739.02 Median:30062.03 stddev:76348.34 (254.0%) stddev-sans-first:76536.83 01:45:10 INFO - PROCESS | 16783 | Values: 361.3 371.6 372.6 373.2 373.9 18216.4 18916.3 20235.1 20339.6 20377.0 18611.4 18883.4 18942.3 19150.0 19202.7 5312.9 5589.9 5607.6 5639.7 5640.6 5172.4 5366.9 5384.9 5408.4 5418.3 5295.3 5347.9 5361.5 6117.8 6189.1 6059.9 6065.2 6068.5 6070.4 6096.5 4996.6 5169.0 5208.3 5456.5 5472.9 13703.9 13731.3 13753.3 16530.9 20868.6 2235.3 2326.1 2369.0 2407.6 2520.0 9610.2 9630.5 9724.6 9774.3 9898.6 1782.1 1850.4 1864.4 1902.5 1933.2 66424.0 67127.7 67252.0 67923.0 68447.0 10292.8 10570.4 10577.7 10722.8 10775.0 14797.0 14884.6 14992.2 14996.1 15013.8 7717.7 7750.5 7780.9 7800.2 7978.6 7105.2 7251.8 7276.1 7312.7 7541.2 4613.7 4706.1 4759.4 4789.3 4864.1 1902.9 1938.8 1940.6 2021.6 2063.5 911.2 983.3 988.9 1062.8 1093.4 17365.0 17792.1 17941.7 18052.2 18512.0 981.9 1005.8 1012.7 1039.1 1067.4 9973.7 10434.7 10443.5 10509.8 10554.9 457398.0 457589.0 469099.0 471377.0 472642.0 76265.6 76284.6 79767.2 80116.0 80273.6 1033.4 1048.7 1058.6 1068.9 1069.7 15688.6 15890.8 15977.8 15986.9 16104.2 26192.7 33931.3 34374.5 34785.7 34835.7 49543.4 49546.5 49637.8 49727.5 50040.7 8543.1 8554.2 8590.8 8601.8 8626.0 12133.9 12817.8 12859.7 12993.4 13108.0 11223.3 11371.5 11383.4 11450.9 11557.5 11810.7 11871.9 11955.8 11995.7 12032.2 11700.4 11927.9 12106.1 12367.9 12502.7 8574.4 8698.2 8736.3 8828.0 8832.2 11271.3 11683.2 11763.8 11896.6 11999.7 01:45:10 INFO - PROCESS | 16783 | 01:45:10 INFO - PROCESS | 16783 | [#3] mootools.html Cycles:180 Average:5717.20 Median:6230.00 stddev:2959.33 (47.5%) stddev-sans-first:2950.68 01:45:10 INFO - PROCESS | 16783 | Values: 1502.8 1540.6 1773.5 1868.0 1917.3 7254.8 7724.3 7933.7 8046.8 8147.5 7968.1 8008.6 8088.5 8100.3 8104.2 2381.4 2414.4 2416.3 2417.8 2419.5 2383.8 2405.5 2440.0 2440.9 2448.6 2410.3 2410.7 2425.8 2455.0 2459.5 2422.1 2436.9 2443.5 2443.6 2453.0 2355.0 2365.7 2370.0 2370.8 2377.7 8206.3 8222.4 8227.8 8266.0 8304.3 4985.0 5122.1 5126.8 5134.3 5139.6 3123.6 3140.5 3183.6 3184.0 3217.1 1019.0 1027.5 1062.2 1071.1 1082.3 11423.8 11440.5 11456.3 11466.8 11538.6 4370.8 4477.7 4505.8 4512.3 4535.3 9053.8 9058.4 9095.0 9099.5 9118.1 5011.3 5020.3 5034.4 5050.6 5063.7 4046.0 4459.2 4524.4 4574.8 4662.2 3673.2 3721.6 3722.3 3744.6 3754.8 1097.2 1101.6 1107.6 1108.7 1111.8 979.6 998.6 1002.2 1157.8 1403.3 7646.2 7892.2 7895.6 7947.1 7951.8 1153.2 1160.7 1171.1 1193.2 1232.6 6059.9 6089.8 6105.5 6113.4 6116.8 9638.7 9941.0 10024.2 10032.2 10069.4 9195.1 9852.4 9861.5 9872.4 9896.6 7818.6 7842.7 7909.4 7912.5 7984.8 7337.8 7582.5 7633.4 7715.0 7763.5 8594.4 8714.2 8802.8 8926.5 8929.7 8776.0 8955.4 9091.6 9130.3 9173.2 6343.2 6864.1 7015.9 7049.6 7167.1 7701.7 7752.0 7775.7 7810.7 7840.1 7033.5 7144.8 7158.0 7214.2 7301.9 6829.9 6839.6 6900.8 6940.2 7008.2 7517.4 7553.2 7612.7 7648.3 7662.7 6767.0 6830.6 6833.8 6873.0 6909.7 6727.6 6766.6 6781.3 6852.4 6886.1 01:45:10 INFO - PROCESS | 16783 | 01:45:10 INFO - PROCESS | 16783 | [#4] prototype.html Cycles:180 Average:5672.95 Median:6479.29 stddev:1761.74 (27.2%) stddev-sans-first:1721.03 01:45:10 INFO - PROCESS | 16783 | Values: 363.8 364.3 367.4 367.7 375.8 6390.4 6430.5 6431.2 6452.9 6466.5 6333.1 6346.7 6359.0 6372.1 6388.5 4664.0 4731.7 4763.6 4765.4 4842.7 4763.6 4778.5 4781.8 4799.2 4804.0 4733.3 4752.9 4753.1 4761.0 4763.9 4709.4 4741.1 4765.0 4770.1 4776.1 4140.5 4156.8 4158.1 4164.3 4167.4 5995.5 6000.8 6020.2 6055.5 6071.6 5376.8 5497.6 5546.4 5560.5 5589.7 6718.0 6719.6 6723.6 6755.5 6764.1 4606.9 4607.5 4611.8 4620.7 4632.7 7037.1 7082.5 7091.5 7107.0 7123.1 4450.1 4725.1 4725.8 4728.4 4733.8 4623.4 4633.5 4647.9 4667.8 4672.8 5454.6 5464.8 5470.3 5480.2 5483.5 6828.9 6843.0 6852.5 6854.2 6875.0 1672.2 1696.0 1703.0 1703.9 1705.0 1057.7 1071.7 1107.8 1108.8 1118.5 6537.4 6547.1 6552.5 6564.6 6565.6 7000.3 7007.6 7028.4 7037.0 7046.9 6389.2 6492.1 6562.8 6627.4 6627.5 3773.5 3854.9 3857.9 3860.7 3863.1 7224.5 7317.8 7380.5 7394.3 7396.1 7268.1 7284.3 7307.5 7359.1 7384.9 7076.3 7365.9 7376.3 7398.7 7401.3 7100.6 7107.9 7109.0 7115.5 7153.1 7027.9 7040.9 7049.0 7058.1 7062.5 7296.8 7311.5 7358.1 7360.1 7388.3 4598.9 4648.9 4714.5 4726.4 4744.4 7038.3 7074.6 7083.3 7086.2 7090.1 6855.2 6855.4 6868.9 6878.4 6888.3 6825.3 6876.0 6887.7 6891.0 6898.4 6564.2 6728.9 6786.9 6817.2 6832.2 6920.9 6944.7 6958.3 6960.2 6980.7 6749.5 6781.1 6802.4 6804.0 6805.0 01:45:10 INFO - PROCESS | 16783 | 01:45:10 INFO - PROCESS | 16783 | [#5] yui.html Cycles:180 Average:14468.57 Median:26639.92 stddev:16543.21 (62.1%) stddev-sans-first:16557.56 01:45:10 INFO - PROCESS | 16783 | Values: 753.9 800.2 827.6 828.3 829.5 16590.8 16934.4 16951.2 16954.0 17027.0 15474.4 15672.9 15763.9 15776.1 15809.9 901.0 923.0 940.9 943.4 946.8 939.1 940.9 941.1 943.7 944.3 971.7 972.5 972.7 974.6 976.9 959.5 962.0 964.6 964.9 973.9 708.9 714.2 715.7 716.4 717.4 14920.9 14940.2 14967.3 15019.4 15043.5 13904.0 14066.6 14193.0 14319.2 14336.6 11064.8 11116.8 11168.7 11192.2 11231.2 3600.3 3647.6 3650.6 3671.0 3726.7 52266.0 52440.0 52927.2 53170.0 53362.5 10666.1 11024.3 11146.4 11261.1 11310.8 20710.0 20813.3 20857.3 20861.8 20921.5 8015.1 8048.5 8122.6 8276.6 8420.5 4197.0 4512.1 4598.4 4634.1 4751.3 3398.6 3406.7 3429.2 3434.8 3436.5 621.2 625.3 682.5 683.7 697.6 576.0 602.6 662.0 674.8 684.0 7855.2 8082.4 8405.1 8424.5 8545.5 520.9 524.3 570.3 640.3 654.7 3749.4 3852.1 3921.6 3948.8 3980.1 55660.0 56352.4 56969.0 57777.0 57972.0 52463.5 52671.2 52898.0 53600.2 53919.0 47067.3 48528.5 48836.0 49722.8 49748.0 7642.5 7649.7 7808.2 7872.3 8159.3 36180.6 36568.5 36597.3 36923.6 37314.3 42567.6 44369.0 45596.0 45956.5 46189.5 11020.9 11404.9 11625.6 11736.8 11817.4 12205.5 12324.7 12408.1 12515.0 12579.4 10716.1 10734.2 10831.4 10854.3 11017.5 11030.2 11247.1 11475.3 11585.7 11591.3 10302.8 10366.7 10415.3 10467.8 10513.7 9603.0 9610.6 9628.7 9875.6 9995.3 9260.7 9428.8 9485.3 9511.6 9566.5 01:45:10 INFO - PROCESS | 16783 | -------- Summary: end -------- 01:45:10 INFO - PROCESS | 16783 | 01:45:11 INFO - TEST-INFO | 16783: exit 0 01:45:11 INFO - TEST-OK | dromaeo_css | took 1109194ms 01:45:11 INFO - TEST-START | kraken 01:45:11 INFO - operating with platform_type : linux_ 01:45:11 INFO - Initialising browser for kraken test... 01:45:11 INFO - TEST-INFO | started process 17037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8lEEi9/profile http://localhost:49129/getInfo.html) 01:45:15 INFO - PROCESS | 17037 | 01:45:15 INFO - PROCESS | 17037 | (process:17116): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:45:16 INFO - PROCESS | 17037 | __metrics Screen width/height:1600/1200 01:45:16 INFO - PROCESS | 17037 | colorDepth:24 01:45:16 INFO - PROCESS | 17037 | Browser inner width/height: 1024/697 01:45:16 INFO - PROCESS | 17037 | __metrics 01:45:16 ERROR - PROCESS | 17037 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 01:45:17 INFO - TEST-INFO | 17037: exit 0 01:45:17 INFO - Browser initialized. 01:45:17 INFO - Running cycle 1/1 for kraken test... 01:45:17 INFO - TEST-INFO | started process 17167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8lEEi9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:45:19 INFO - PROCESS | 17167 | 01:45:19 INFO - PROCESS | 17167 | (process:17234): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:45:29 INFO - PROCESS | 17167 | RSS: Main: 151367680 01:45:29 INFO - PROCESS | 17167 | 01:45:31 INFO - PROCESS | 17167 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49129/tests/kraken/driver.html?testName=audio-beat-detection) 01:45:32 INFO - PROCESS | 17167 | RSS: Main: 156028928 01:45:32 INFO - PROCESS | 17167 | 01:45:35 INFO - PROCESS | 17167 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49129/tests/kraken/driver.html?testName=audio-dft) 01:45:35 INFO - PROCESS | 17167 | RSS: Main: 156569600 01:45:35 INFO - PROCESS | 17167 | 01:45:38 INFO - PROCESS | 17167 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49129/tests/kraken/driver.html?testName=audio-fft) 01:45:39 INFO - PROCESS | 17167 | RSS: Main: 157016064 01:45:39 INFO - PROCESS | 17167 | 01:45:41 INFO - PROCESS | 17167 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49129/tests/kraken/driver.html?testName=audio-oscillator) 01:45:41 INFO - PROCESS | 17167 | RSS: Main: 157323264 01:45:41 INFO - PROCESS | 17167 | 01:45:44 INFO - PROCESS | 17167 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49129/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:45:44 INFO - PROCESS | 17167 | RSS: Main: 156958720 01:45:44 INFO - PROCESS | 17167 | 01:45:47 INFO - PROCESS | 17167 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49129/tests/kraken/driver.html?testName=imaging-darkroom) 01:45:48 INFO - PROCESS | 17167 | RSS: Main: 157130752 01:45:48 INFO - PROCESS | 17167 | 01:45:51 INFO - PROCESS | 17167 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49129/tests/kraken/driver.html?testName=imaging-desaturate) 01:45:52 INFO - PROCESS | 17167 | RSS: Main: 157147136 01:45:52 INFO - PROCESS | 17167 | 01:45:55 INFO - PROCESS | 17167 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49129/tests/kraken/driver.html?testName=json-parse-financial) 01:45:55 INFO - PROCESS | 17167 | RSS: Main: 157102080 01:45:55 INFO - PROCESS | 17167 | 01:45:57 INFO - PROCESS | 17167 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49129/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:45:57 INFO - PROCESS | 17167 | RSS: Main: 157040640 01:45:57 INFO - PROCESS | 17167 | 01:45:59 INFO - PROCESS | 17167 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:46:00 INFO - PROCESS | 17167 | RSS: Main: 156467200 01:46:00 INFO - PROCESS | 17167 | 01:46:02 INFO - PROCESS | 17167 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:46:02 INFO - PROCESS | 17167 | RSS: Main: 156889088 01:46:02 INFO - PROCESS | 17167 | 01:46:05 INFO - PROCESS | 17167 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:46:05 INFO - PROCESS | 17167 | RSS: Main: 157052928 01:46:05 INFO - PROCESS | 17167 | 01:46:08 INFO - PROCESS | 17167 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:46:08 INFO - PROCESS | 17167 | RSS: Main: 157630464 01:46:08 INFO - PROCESS | 17167 | 01:46:10 INFO - PROCESS | 17167 | Cycle 1(1): loaded http://localhost:49129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49129/tests/kraken/driver.html?testName=ai-astar) 01:46:10 INFO - PROCESS | 17167 | RSS: Main: 159334400 01:46:10 INFO - PROCESS | 17167 | 01:46:10 INFO - PROCESS | 17167 | __start_tp_report 01:46:10 INFO - PROCESS | 17167 | _x_x_mozilla_page_load 01:46:10 INFO - PROCESS | 17167 | _x_x_mozilla_page_load_details 01:46:10 INFO - PROCESS | 17167 | |i|pagename|runs| 01:46:10 INFO - PROCESS | 17167 | |0;ai-astar;112;105;112;111;111;120;110;110;111;111 01:46:10 INFO - PROCESS | 17167 | |1;audio-beat-detection;152;133;163;174;128;153;152;133;174;134 01:46:10 INFO - PROCESS | 17167 | |2;audio-dft;162;163;163;162;164;164;164;164;168;163 01:46:10 INFO - PROCESS | 17167 | |3;audio-fft;73;77;74;167;77;76;76;74;174;76 01:46:10 INFO - PROCESS | 17167 | |4;audio-oscillator;93;93;144;92;92;93;149;92;93;138 01:46:10 INFO - PROCESS | 17167 | |5;imaging-gaussian-blur;118;117;117;118;117;117;118;117;118;118 01:46:10 INFO - PROCESS | 17167 | |6;imaging-darkroom;151;148;148;147;148;147;147;148;148;146 01:46:10 INFO - PROCESS | 17167 | |7;imaging-desaturate;96;96;97;96;97;99;97;98;96;97 01:46:10 INFO - PROCESS | 17167 | |8;json-parse-financial;54;58;56;58;55;56;57;63;57;55 01:46:10 INFO - PROCESS | 17167 | |9;json-stringify-tinderbox;68;66;66;66;68;67;68;66;65;66 01:46:10 INFO - PROCESS | 17167 | |10;stanford-crypto-aes;79;78;81;78;82;79;79;79;79;80 01:46:10 INFO - PROCESS | 17167 | |11;stanford-crypto-ccm;113;112;119;120;115;116;124;116;127;120 01:46:10 INFO - PROCESS | 17167 | |12;stanford-crypto-pbkdf2;140;147;148;147;151;136;136;150;151;144 01:46:10 INFO - PROCESS | 17167 | |13;stanford-crypto-sha256-iterative;70;72;71;69;75;69;69;69;68;68 01:46:10 INFO - PROCESS | 17167 | __end_tp_report 01:46:10 INFO - PROCESS | 17167 | __start_cc_report 01:46:10 INFO - PROCESS | 17167 | _x_x_mozilla_cycle_collect,849 01:46:10 INFO - PROCESS | 17167 | __end_cc_report 01:46:10 INFO - PROCESS | 17167 | __startTimestamp1461487570954__endTimestamp 01:46:10 INFO - PROCESS | 17167 | 01:46:10 INFO - PROCESS | 17167 | ------- Summary: start ------- 01:46:10 INFO - PROCESS | 17167 | Number of tests: 14 01:46:10 INFO - PROCESS | 17167 | 01:46:10 INFO - PROCESS | 17167 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:3.65 (3.3%) stddev-sans-first:3.87 01:46:10 INFO - PROCESS | 17167 | Values: 112.0 105.0 112.0 111.0 111.0 120.0 110.0 110.0 111.0 111.0 01:46:10 INFO - PROCESS | 17167 | 01:46:10 INFO - PROCESS | 17167 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:152.50 stddev:17.17 (11.3%) stddev-sans-first:18.19 01:46:10 INFO - PROCESS | 17167 | Values: 152.0 133.0 163.0 174.0 128.0 153.0 152.0 133.0 174.0 134.0 01:46:10 INFO - PROCESS | 17167 | 01:46:10 INFO - PROCESS | 17167 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:1.70 (1.0%) stddev-sans-first:1.69 01:46:10 INFO - PROCESS | 17167 | Values: 162.0 163.0 163.0 162.0 164.0 164.0 164.0 164.0 168.0 163.0 01:46:10 INFO - PROCESS | 17167 | 01:46:10 INFO - PROCESS | 17167 | [#3] audio-fft Cycles:10 Average:94.40 Median:76.00 stddev:40.16 (52.8%) stddev-sans-first:41.85 01:46:10 INFO - PROCESS | 17167 | Values: 73.0 77.0 74.0 167.0 77.0 76.0 76.0 74.0 174.0 76.0 01:46:10 INFO - PROCESS | 17167 | 01:46:10 INFO - PROCESS | 17167 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:92.50 stddev:24.82 (26.8%) stddev-sans-first:25.73 01:46:10 INFO - PROCESS | 17167 | Values: 93.0 93.0 144.0 92.0 92.0 93.0 149.0 92.0 93.0 138.0 01:46:10 INFO - PROCESS | 17167 | 01:46:10 INFO - PROCESS | 17167 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 01:46:10 INFO - PROCESS | 17167 | Values: 118.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 118.0 118.0 01:46:10 INFO - PROCESS | 17167 | 01:46:10 INFO - PROCESS | 17167 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.32 (0.9%) stddev-sans-first:0.73 01:46:10 INFO - PROCESS | 17167 | Values: 151.0 148.0 148.0 147.0 148.0 147.0 147.0 148.0 148.0 146.0 01:46:10 INFO - PROCESS | 17167 | 01:46:10 INFO - PROCESS | 17167 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:0.99 (1.0%) stddev-sans-first:1.00 01:46:10 INFO - PROCESS | 17167 | Values: 96.0 96.0 97.0 96.0 97.0 99.0 97.0 98.0 96.0 97.0 01:46:10 INFO - PROCESS | 17167 | 01:46:10 INFO - PROCESS | 17167 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:2.51 (4.4%) stddev-sans-first:2.44 01:46:10 INFO - PROCESS | 17167 | Values: 54.0 58.0 56.0 58.0 55.0 56.0 57.0 63.0 57.0 55.0 01:46:10 INFO - PROCESS | 17167 | 01:46:10 INFO - PROCESS | 17167 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:66.50 stddev:1.07 (1.6%) stddev-sans-first:1.01 01:46:10 INFO - PROCESS | 17167 | Values: 68.0 66.0 66.0 66.0 68.0 67.0 68.0 66.0 65.0 66.0 01:46:10 INFO - PROCESS | 17167 | 01:46:10 INFO - PROCESS | 17167 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:1.26 (1.6%) stddev-sans-first:1.33 01:46:10 INFO - PROCESS | 17167 | Values: 79.0 78.0 81.0 78.0 82.0 79.0 79.0 79.0 79.0 80.0 01:46:10 INFO - PROCESS | 17167 | 01:46:10 INFO - PROCESS | 17167 | [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:119.50 stddev:4.76 (4.0%) stddev-sans-first:4.66 01:46:10 INFO - PROCESS | 17167 | Values: 113.0 112.0 119.0 120.0 115.0 116.0 124.0 116.0 127.0 120.0 01:46:10 INFO - PROCESS | 17167 | 01:46:10 INFO - PROCESS | 17167 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:147.50 stddev:5.79 (3.9%) stddev-sans-first:5.85 01:46:10 INFO - PROCESS | 17167 | Values: 140.0 147.0 148.0 147.0 151.0 136.0 136.0 150.0 151.0 144.0 01:46:10 INFO - PROCESS | 17167 | 01:46:10 INFO - PROCESS | 17167 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:69.50 stddev:2.16 (3.1%) stddev-sans-first:2.29 01:46:10 INFO - PROCESS | 17167 | Values: 70.0 72.0 71.0 69.0 75.0 69.0 69.0 69.0 68.0 68.0 01:46:10 INFO - PROCESS | 17167 | -------- Summary: end -------- 01:46:10 INFO - PROCESS | 17167 | 01:46:11 INFO - TEST-INFO | 17167: exit 0 01:46:11 INFO - TEST-OK | kraken | took 60249ms 01:46:11 INFO - SUITE-END | took 1169s 01:46:12 INFO - Completed test suite (00:19:29) 01:46:12 INFO - javascript benchmark 01:46:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3306.2726200235948, 3338.2488939988507, 3340.498925161224, 3357.4963755436684, 3376.898693039208, 5421.647592906464, 5469.644473109245, 5485.561155107592, 5510.393856675762, 5522.861928451791, 5533.861653458665, 5543.695096769676, 5552.333719953611, 5552.583556233279, 5557.972210138953, 5021.874453138674, 5078.4159821620615, 5079.517445842639, 5138.974305128488, 5161.458046905077, 5070.771815268304, 5078.898422031557, 5094.235864620318, 5121.12940800063, 5126.436092029874, 5034.697918124924, 5089.0, 5096.643234973553, 5098.184290513518, 5179.352580927384, 5116.334876466073, 5158.12311906973, 5168.0, 5180.456052114511, 5203.323567936182, 4965.975170124162, 4987.675801072919, 5010.473900240495, 5062.0888240116765, 5068.797248110071, 5276.182191760283, 5298.92051619226, 5313.57491400687, 5316.813911513117, 5347.759350829222, 5865.237519122486, 5872.265966754156, 5878.41215878413, 5879.470847623735, 5892.882142357129, 5801.53587712982, 5826.679532625704, 5866.589338746289, 5892.558058145613, 5930.110483427477, 5549.361823390281, 5588.720563971785, 5624.859378515529, 5624.971875140598, 5630.239917611152, 5961.374055724174, 6058.787942421994, 6089.208402907594, 6102.847428814315, 6105.511559075263, 5888.175655408247, 5950.137230101697, 5956.106584012433, 5961.821145365646, 5963.761449541969, 6041.365656605993, 6062.090686397076, 6063.696815159225, 6068.969655151696, 6082.513398928075, 5668.376478587352, 5947.464728174398, 6005.189299444606, 6005.789797357159, 6011.038233882645, 5994.0, 5999.430054144849, 6007.609505382136, 6026.0, 6052.757889684452, 4542.318652202196, 4549.135664223787, 4556.2937744649635, 4563.110193512233, 4582.152301824173, 4005.4792876925812, 4038.8586399475876, 4073.6130067643526, 4104.651104656078, 4125.216208920296, 5463.453654634504, 5673.404292549306, 5695.7152142392715, 5698.6580805151, 5766.942330576724, 5867.823965281048, 5885.499732522698, 5892.0, 5933.110033494924, 5934.673592952343, 5560.165975103767, 5578.860528486739, 5590.944090559043, 5603.551715862721, 5659.405762394971, 5047.041062198171, 5070.3155074064525, 5100.6429549931145, 5123.257127716461, 5151.5878729701535, 5987.940120598738, 6036.034234522544, 6040.758369665252, 6062.302835174011, 6062.969685151635, 5880.647161170344, 5898.970505147447, 5902.6458412495385, 5903.203067585821, 5924.052151655801, 6036.63780173191, 6114.084479019511, 6115.727150604437, 6129.5150668530305, 6136.365905528278, 5950.3454619992635, 5957.851053723518, 5965.9105113422465, 5970.611910225822, 5973.761049557969, 5815.273090863642, 6016.7292471838, 6018.909716354171, 6036.456718895321, 6068.544859135671, 5884.9705751470965, 5886.3525012247765, 5900.468957793648, 5919.141724450017, 5945.227120474311, 5899.67551784656, 5900.70496475166, 5910.497607703393, 5912.349641539513, 5912.73392697321, 5718.228039214653, 5740.598158128891, 5787.392323806108, 5790.855228619318, 5824.097264923944, 5720.399358067343, 5820.330661973927, 5831.766729330949, 5836.533077353716, 5870.031444811559, 5697.059985102577, 5701.116326969326, 5712.885742285048, 5716.79991200306, 5747.9137812932], "unit": "score", "name": "dojo.html", "value": 5491.6346166967}, {"lowerIsBetter": false, "replicates": [551.2558046637039, 563.7547666764955, 570.940051294614, 585.3531847308724, 645.3546453546453, 38552.614473855254, 39063.80468097656, 39145.0, 39216.60783392169, 39310.410343844866, 42926.78536607321, 43474.13051738963, 43490.78254608723, 43565.0, 43660.56339436604, 8841.160089791476, 8920.241779448756, 8932.64269429222, 8959.686410975584, 9064.18422341989, 8877.334199934998, 8985.77535561613, 9015.233705135071, 9024.18782309592, 9046.276297896185, 9192.632294708237, 9215.861762073575, 9234.722958311262, 9295.58169882357, 9323.0, 9158.450492970409, 9263.907360926405, 9274.860877086849, 9290.117438843366, 9303.976562578111, 9079.0, 9193.816123677556, 9200.309976751703, 9207.67773127944, 9216.49309287989, 42825.0, 43181.704548863585, 43199.56800432019, 43237.56762432367, 43371.34942975858, 3558.822058897045, 3629.0, 3668.761530500509, 3746.606606306353, 3751.6623503884507, 29416.558751618744, 29465.0, 29567.40865182684, 30169.0, 30228.0, 4372.628326592244, 4375.453068366454, 4384.21084204843, 4429.756363400012, 4457.442819647544, 287136.0, 288769.0, 290013.0, 291850.0, 292169.0, 45826.08347833091, 45909.540904590525, 68114.0, 69075.0, 69228.30771692218, 44017.119657606665, 44166.0, 44240.0, 44328.335074973904, 44330.55669443329, 15600.375984960701, 15716.057036577842, 15765.527034188992, 15774.68450630981, 15817.762733559006, 12444.440000200013, 12469.501219951282, 12488.313142777053, 12570.434330455151, 12607.369631518388, 15043.623909402353, 15618.609534761721, 15642.374305027672, 15702.607434814221, 15827.52517424479, 6131.210299313801, 6153.661548614869, 6210.099535567408, 6221.5333849961435, 6347.619142851444, 1015.426284149468, 1065.9147268218524, 1095.9726006849733, 1125.5666568371237, 1157.9131565132648, 28904.85547572249, 29369.265768355534, 29520.409591808475, 29597.408051838844, 32620.18449538733, 1143.188336281233, 1144.4964215745047, 1144.9828252576217, 1153.7481832212143, 1206.4872429217548, 15133.0, 15317.770233446507, 15411.691766164615, 15448.304826282843, 15807.972481788647, 315478.0, 549413.0, 550227.0, 554663.0, 827115.0, 58139.0, 58783.11825322624, 58993.705031474565, 59053.70473147693, 59196.0, 1510.8489151084805, 1528.4803166923077, 1534.0795522686522, 1553.0914415067311, 1559.391837183522, 29288.41423171482, 30207.244818879703, 30280.0, 30489.23776905595, 30656.08031759051, 50964.49035509597, 51122.233166503276, 51366.74316628393, 51367.48632513777, 51424.48575514197, 303730.0, 304052.0, 305974.0, 306211.0, 306263.0, 35155.824220878734, 35392.29215415626, 35557.64442355543, 35662.82168589244, 35796.284074318886, 47423.76288118537, 47914.0, 51297.487025130766, 52446.475535245685, 52847.207291889885, 36032.27935441329, 37980.0, 40429.595704042586, 40498.59501404948, 41002.79498602488, 39558.80220598879, 40431.3935290965, 41087.178256435305, 41430.0, 41620.0, 38131.42802857904, 38947.0, 39019.804900975316, 39373.637581745184, 39489.2102157961, 34697.1325716849, 35230.47154292637, 35252.294954101286, 35363.0, 35432.29135417226, 26832.8658356707, 27539.862300688368, 27543.31141721473, 27590.172294831187, 27797.58303625407], "unit": "score", "name": "ext.html", "value": 19520.251724317608}, {"lowerIsBetter": false, "replicates": [361.34957077260924, 371.57640290069327, 372.60317761583894, 373.2218324792807, 373.9326921154193, 18216.362427315045, 18916.337928172517, 20235.089420976055, 20339.59320813583, 20377.0, 18611.441656750285, 18883.433496995112, 18942.337018204365, 19150.0, 19202.711959320623, 5312.893742125155, 5589.888202235943, 5607.635503692268, 5639.746211420496, 5640.576956728241, 5172.405173405069, 5366.865828354284, 5384.865378365533, 5408.3509978802595, 5418.29562156919, 5295.338082739658, 5347.946520534803, 5361.490658387447, 6117.785877494289, 6189.071639254125, 6059.939400605982, 6065.211522502069, 6068.453839154476, 6070.362611925729, 6096.4513193812545, 4996.600271978233, 5168.9741551292, 5208.2968799212, 5456.454354564551, 5472.890542189174, 13703.90368770496, 13731.313434328244, 13753.312334383341, 16530.917345413316, 20868.5826283475, 2235.284708893155, 2326.1160758911674, 2369.0, 2407.5546023985617, 2519.9794083396255, 9610.231181505464, 9630.47032413217, 9724.562394692184, 9774.26692998028, 9898.604055837757, 1782.064416181515, 1850.3523766681553, 1864.3567969050655, 1902.533879199605, 1933.1880610143774, 66424.0, 67127.66436167837, 67252.0, 67922.98115528272, 68447.0, 10292.794144117075, 10570.418626975435, 10577.682669519927, 10722.78554428907, 10775.0, 14797.0, 14884.553463396116, 14992.175430351435, 14996.100233985995, 15013.774793378108, 7717.729879454305, 7750.457467977188, 7780.949571807733, 7800.180980997027, 7978.6409611567615, 7105.218425973138, 7251.782446526613, 7276.126864776261, 7312.707491700379, 7541.208173141741, 4613.65397595175, 4706.058788242365, 4759.38128043359, 4789.30555069513, 4864.148773964542, 1902.942911712623, 1938.806119388078, 1940.553672655297, 2021.6057868715754, 2063.546019875625, 911.1799380557551, 983.2625530851861, 988.945607991553, 1062.824633935392, 1093.4150229627112, 17365.0, 17792.110394480223, 17941.7308740369, 18052.18765155545, 18512.0, 981.906718861707, 1005.7586179317058, 1012.6658202793061, 1039.142707266508, 1067.386252904583, 9973.650922217688, 10434.739131521621, 10443.530041148166, 10509.84235236472, 10554.947225263979, 457398.0, 457589.0, 469099.0, 471377.0, 472642.0, 76265.61867190628, 76284.61857690677, 79767.20232797714, 80116.0, 80273.59863200647, 1033.4161198922584, 1048.6853943816825, 1058.571278632155, 1068.930519516229, 1069.6897899609025, 15688.607784805472, 15890.841091588936, 15977.840221597635, 15986.920065399598, 16104.194790260675, 26192.73807261903, 33931.3213735719, 34374.484382733775, 34785.65214347925, 34835.65164348324, 49543.44272100146, 49546.50453495563, 49637.75181124071, 49727.502724972284, 50040.749796250784, 8543.145685431407, 8554.230119289294, 8590.828183436171, 8601.827963440572, 8626.0, 12133.939330303292, 12817.807732883828, 12859.678508037, 12993.4152963115, 13108.0, 11223.326600404002, 11371.54513819438, 11383.373914434454, 11450.885491145315, 11557.537698491966, 11810.704732381759, 11871.881281187423, 11955.76088478243, 11995.700107497383, 12032.157748957488, 11700.35648039332, 11927.940360298144, 12106.065528703382, 12367.876321237032, 12502.749945001231, 8574.442661227, 8698.21716045559, 8736.25741811953, 8827.955860220658, 8832.205101540892, 11271.323720576464, 11683.240589361665, 11763.823542647038, 11896.583619573274, 11999.700007499534], "unit": "score", "name": "jquery.html", "value": 8804.67755435667}, {"lowerIsBetter": false, "replicates": [1502.8271748748894, 1540.591743188055, 1773.5211492896917, 1867.9813201867978, 1917.2810196176433, 7254.782356529299, 7724.304812566867, 7933.722319718811, 8046.758597242085, 8147.470414423065, 7968.083670377909, 8008.559529225905, 8088.514689118657, 8100.270975612194, 8104.230098140682, 2381.3808409813487, 2414.4446777241246, 2416.3113512648897, 2417.830751847371, 2419.52819200256, 2383.8212134090013, 2405.494846082316, 2439.9878000609974, 2440.8779561021965, 2448.608222684371, 2410.276916924924, 2410.674558934548, 2425.805935525154, 2455.0, 2459.5449841779237, 2422.0917156066475, 2436.8537887726707, 2443.450223699671, 2443.596806526921, 2452.9632055519182, 2355.0108954239263, 2365.7042869641296, 2369.988150059256, 2370.798482129021, 2377.702787151606, 8206.302464290542, 8222.424430289882, 8227.753167404988, 8265.95867020661, 8304.294134998532, 4985.0, 5122.078025955327, 5126.846194614168, 5134.332536770234, 5139.61452891031, 3123.6407813101555, 3140.4661207594763, 3183.554302397666, 3184.028871194285, 3217.0992122205585, 1018.9745256368576, 1027.5273374247781, 1062.2351906627216, 1071.1002757683584, 1082.258652822819, 11423.828642570368, 11440.542378304857, 11456.255343402652, 11466.770664586746, 11538.596149134824, 4370.759608221515, 4477.686561940698, 4505.797239124247, 4512.278035514302, 4535.251683472256, 9053.77365565866, 9058.365914386062, 9095.045020272908, 9099.499527525917, 9118.133777291147, 5011.323471331397, 5020.297158397827, 5034.421041580192, 5050.570701490341, 5063.721495317719, 4045.9797701011894, 4459.152760975404, 4524.366588677588, 4574.771261436915, 4662.184117779375, 3673.228621989412, 3721.5906250312446, 3722.2555488901785, 3744.5693745219105, 3754.755940863835, 1097.1771171621283, 1101.6309536305428, 1107.5791199344199, 1108.6563165418745, 1111.7609713911386, 979.5983646704817, 998.6305067125065, 1002.2433063037506, 1157.7568710570706, 1403.3474434388058, 7646.197149299243, 7892.171322011221, 7895.644695988694, 7947.125816160218, 7951.761447156595, 1153.1581945180067, 1160.721426857565, 1171.1158075652997, 1193.236328749601, 1232.550119206501, 6059.878802423927, 6089.786857459968, 6105.542084343692, 6113.38866113394, 6116.816495505142, 9638.710838674851, 9941.0, 10024.248181386425, 10032.197424206046, 10069.446180459998, 9195.126462986005, 9852.408855468695, 9861.457619830979, 9872.35829671069, 9896.55465504054, 7818.569978651115, 7842.686292548348, 7909.406794490321, 7912.4856884302335, 7984.800379990431, 7337.816554586178, 7582.54504729718, 7633.351165151024, 7715.0, 7763.456558041109, 8594.441361311494, 8714.215720585178, 8802.779930501789, 8926.464412135292, 8929.73210803677, 8776.0, 8955.41789783662, 9091.59087841062, 9130.315226358183, 9173.174414302744, 6343.175387199634, 6864.141982252218, 7015.859682806417, 7049.6122713249215, 7167.104111986002, 7701.6534255957495, 7752.0, 7775.650095745592, 7810.687572497037, 7840.098388685375, 7033.542819716702, 7144.785656430316, 7157.964210178916, 7214.170370407261, 7301.926980730124, 6829.931700683128, 6839.555428897106, 6900.7929762107215, 6940.236573976757, 7008.159020917318, 7517.398608111229, 7553.206913274027, 7612.733554325572, 7648.273414025659, 7662.655180517002, 6766.966165169143, 6830.59016459014, 6833.794986150423, 6872.965635171792, 6909.689063992233, 6727.562708424132, 6766.560173588701, 6781.2879647638265, 6852.417544508772, 6886.070380498569], "unit": "score", "name": "mootools.html", "value": 4691.090869034607}, {"lowerIsBetter": false, "replicates": [363.80718219343726, 364.27327481674064, 367.44332336510183, 367.7425801938643, 375.79143575315703, 6390.424861762441, 6430.485561155108, 6431.163948686664, 6452.935470645298, 6466.515011374142, 6333.050042493628, 6346.714397852096, 6358.9825627899545, 6372.076048972896, 6388.48892088633, 4664.0, 4731.692439991407, 4763.595094416979, 4765.380500534926, 4842.709437433748, 4763.642726795487, 4778.474367819537, 4781.8087276508895, 4799.18413869643, 4803.975980120112, 4733.337332773414, 4752.85741427756, 4753.096911586787, 4761.047790441909, 4763.928541071887, 4709.387779588666, 4741.099191153687, 4764.999999999965, 4770.117528257283, 4776.09254241693, 4140.523839758406, 4156.8129434175235, 4158.147579746144, 4164.292070348048, 4167.395727619509, 5995.52035837132, 6000.789972350947, 6020.217371741645, 6055.515558755289, 6071.574989750719, 5376.758045887945, 5497.642653227527, 5546.389897111315, 5560.499555040025, 5589.7205139743255, 6717.966410167918, 6719.563228390139, 6723.562968407086, 6755.493337999621, 6764.086848275469, 4606.930896036529, 4607.470140933769, 4611.83858564952, 4620.699654522446, 4632.652551058684, 7037.120359955005, 7082.504224704273, 7091.468139889581, 7106.964465177641, 7123.145222573273, 4450.06548624786, 4725.078609671081, 4725.763711814396, 4728.361671174347, 4733.834315798999, 4623.3758442609815, 4633.513481084505, 4647.86056418308, 4667.766611669403, 4672.766361681903, 5454.59090568209, 5464.7814087436855, 5470.261514695545, 5480.232767412565, 5483.506484416422, 6828.863422731518, 6843.0077638742105, 6852.5203235773015, 6854.177498700088, 6875.0, 1672.180631490561, 1695.9576010599833, 1702.9574260643583, 1703.9062851543035, 1705.0451747021707, 1057.677408390433, 1071.7159952612565, 1107.76736885255, 1108.8170451875512, 1118.4854966715238, 6537.378948999837, 6547.148870646785, 6552.475801935833, 6564.606123632598, 6565.573237739532, 7000.264972177848, 7007.649617519103, 7028.437724981989, 7037.049998250171, 7046.894296585555, 6389.169407976933, 6492.058651495507, 6562.77030303937, 6627.436667883284, 6627.5029372797235, 3773.4905787718853, 3854.8650797221962, 3857.9228415431535, 3860.6718428933295, 3863.092173339263, 7224.4581656375985, 7317.780466586011, 7380.483366164424, 7394.260573942563, 7396.149442814145, 7268.0914885639295, 7284.307990740871, 7307.451941104438, 7359.1169059713175, 7384.889226661604, 7076.25699301566, 7365.926340736632, 7376.299251571092, 7398.741044063539, 7401.296876796696, 7100.609466479394, 7107.857842843011, 7109.040279562193, 7115.53749006313, 7153.105861767279, 7027.9297207027275, 7040.929590704028, 7049.0, 7058.082449281561, 7062.4703147263135, 7296.817579560554, 7311.488195826241, 7358.11702595692, 7360.116785985716, 7388.298111679382, 4598.931016034695, 4648.86053418398, 4714.528547145395, 4726.432828060655, 4744.383230180192, 7038.331358520933, 7074.646267686698, 7083.327083927019, 7086.185088714864, 7090.149182098181, 6855.211650660238, 6855.417289530246, 6868.896966545606, 6878.449724021966, 6888.276730943379, 6825.317468253135, 6876.0, 6887.690053947685, 6891.035255064195, 6898.413634841095, 6564.179477565304, 6728.932710672831, 6786.898196526958, 6817.181938167253, 6832.180138383425, 6920.896186557105, 6944.722211111499, 6958.269381714847, 6960.199577048502, 6980.685869136003, 6749.460043196631, 6781.050652908498, 6802.421794147553, 6804.0, 6804.965975170093], "unit": "score", "name": "prototype.html", "value": 5100.588832203586}, {"lowerIsBetter": false, "replicates": [753.8869169624555, 800.2477670989273, 827.5572568675758, 828.3166387730122, 829.4525613095351, 16590.834091659093, 16934.40729574465, 16951.237194326255, 16954.0, 17027.0, 15474.381024759025, 15672.921635391807, 15763.92118039411, 15776.053436793773, 15809.893307468481, 900.9504477253765, 923.0308176414771, 940.8635747816562, 943.4339396362162, 946.7775072857872, 939.0797018921461, 940.9153176214139, 941.1294552538908, 943.6791490893095, 944.2729098594078, 971.6842026341432, 972.4505654305295, 972.6692924405701, 974.585801034561, 976.9316147869652, 959.4674955399751, 962.0379620379621, 964.5804075227263, 964.9469279189642, 973.9220862331032, 708.9149302083783, 714.1786945013224, 715.7316006497564, 716.3517017099481, 717.3722992381666, 14920.850791492056, 14940.178290194035, 14967.326470308863, 15019.399224031025, 15043.548693539211, 13904.0, 14066.578002659937, 14193.0, 14319.212443315613, 14336.64158396038, 11064.778704425948, 11116.777664446667, 11168.720781980515, 11192.216544841864, 11231.21381503295, 3600.2979419013304, 3647.5805282392334, 3650.5984341722387, 3670.963290367089, 3726.720495962814, 52266.0, 52440.0, 52927.20609190865, 53170.0, 53362.466375336524, 10666.093382062612, 11024.32983100949, 11146.386948717736, 11261.099112071015, 11310.830337544943, 20710.0, 20813.271535496184, 20857.269995550385, 20861.791382085983, 20921.47696307574, 8015.078265999368, 8048.5170889746805, 8122.634481448349, 8276.627551760184, 8420.452670576393, 4197.0, 4512.075024619945, 4598.356230127785, 4634.119517291771, 4751.3348131261655, 3398.575178102737, 3406.693397594179, 3429.2455659754814, 3434.8110853902776, 3436.536067630838, 621.1955517604713, 625.3465128940269, 682.5256446769547, 683.7025893736142, 697.6337422853043, 575.9539236861041, 602.5962605054624, 661.9702113404908, 674.7672053141658, 684.0320945861649, 7855.214478552099, 8082.353411727047, 8405.07544170153, 8424.452410593292, 8545.487270763773, 520.88800907805, 524.2817340243814, 570.3327107284487, 640.2573015302227, 654.7282877605741, 3749.362608356586, 3852.1494094370523, 3921.5882332355263, 3948.842280292126, 3980.144268982183, 55660.0, 56352.436475635535, 56969.0, 57777.0, 57972.0, 52463.47536524586, 52671.20993185105, 52898.0, 53600.19599706007, 53919.0, 47067.293990590166, 48528.5147148531, 48836.0, 49722.75138624356, 49748.0, 7642.4650274480255, 7649.655765490677, 7808.180141085104, 7872.330851877655, 8159.306458951056, 36180.63819361773, 36568.45147322739, 36597.26805463929, 36923.630763693094, 37314.25371492609, 42567.57432425636, 44369.0, 45596.0, 45956.540434596565, 46189.53810461852, 11020.889791102307, 11404.94297528507, 11625.59310424131, 11736.823947640964, 11817.409129543661, 12205.450754716237, 12324.691882702646, 12408.069394795246, 12515.0, 12579.371031448209, 10716.142708583138, 10734.248602597743, 10831.350118992885, 10854.29447085937, 11017.504212310625, 11030.172737044593, 11247.100231981585, 11475.311481311148, 11585.7103572408, 11591.304521728724, 10302.845457317997, 10366.740831479274, 10415.270931034755, 10467.842982355118, 10513.737156570842, 9603.0, 9610.567524461556, 9628.71113866585, 9875.604975800887, 9995.250356223458, 9260.722178334661, 9428.811423771624, 9485.33602647808, 9511.571979261089, 9566.473843938371], "unit": "score", "name": "yui.html", "value": 6657.395934896576}], "name": "dromaeo_css", "value": 7292.154921555927}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 112.0, 111.0, 111.0, 120.0, 110.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [152.0, 133.0, 163.0, 174.0, 128.0, 153.0, 152.0, 133.0, 174.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 162.0, 164.0, 164.0, 164.0, 164.0, 168.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 74.0, 167.0, 77.0, 76.0, 76.0, 74.0, 174.0, 76.0], "unit": "score", "name": "audio-fft", "value": 94.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 144.0, 92.0, 92.0, 93.0, 149.0, 92.0, 93.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.5}, {"lowerIsBetter": true, "replicates": [151.0, 148.0, 148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 97.0, 99.0, 97.0, 98.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [54.0, 58.0, 56.0, 58.0, 55.0, 56.0, 57.0, 63.0, 57.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 66.0, 66.0, 68.0, 67.0, 68.0, 66.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.6}, {"lowerIsBetter": true, "replicates": [79.0, 78.0, 81.0, 78.0, 82.0, 79.0, 79.0, 79.0, 79.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.4}, {"lowerIsBetter": true, "replicates": [113.0, 112.0, 119.0, 120.0, 115.0, 116.0, 124.0, 116.0, 127.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.2}, {"lowerIsBetter": true, "replicates": [140.0, 147.0, 148.0, 147.0, 151.0, 136.0, 136.0, 150.0, 151.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 71.0, 69.0, 75.0, 69.0, 69.0, 69.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1525.2}]} 01:46:12 INFO - Return code: 0 01:46:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:46:12 ERROR - # TBPL SUCCESS # 01:46:12 INFO - Running post-action listener: _resource_record_post_action 01:46:12 INFO - Running post-run listener: _resource_record_post_run 01:46:13 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 501358592; Read time: 0; Write time: 522532 01:46:13 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245207040; Read time: 0; Write time: 349688 01:46:13 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 256151552; Read time: 0; Write time: 172844 01:46:13 INFO - Running post-run listener: _upload_blobber_files 01:46:13 INFO - Blob upload gear active. 01:46:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:46:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:46:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:46:13 INFO - (blobuploader) - INFO - Open directory for files ... 01:46:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:46:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:46:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:46:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:46:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:46:14 INFO - (blobuploader) - INFO - Done attempting. 01:46:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:46:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:46:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:46:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:46:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:46:15 INFO - (blobuploader) - INFO - Done attempting. 01:46:15 INFO - (blobuploader) - INFO - Iteration through files over. 01:46:15 INFO - Return code: 0 01:46:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:46:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:46:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ef61d8d081b91554c152b8fdfa51d5c798a3e577128709b409a62c748258df72bb7ca4f75520f5a5ef3f3ebce4f327acb112527bc7c3f30773a82a7d4d0f7b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38737c62bc0d7f277151738622578aa495a6bf6c530b70163a058b5fba98a276a15778a4e2d7ce0ad061abf35a2d2a1ca517ff35e87c3703dcdece72ef544531"} 01:46:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:46:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:46:15 INFO - Contents: 01:46:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ef61d8d081b91554c152b8fdfa51d5c798a3e577128709b409a62c748258df72bb7ca4f75520f5a5ef3f3ebce4f327acb112527bc7c3f30773a82a7d4d0f7b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38737c62bc0d7f277151738622578aa495a6bf6c530b70163a058b5fba98a276a15778a4e2d7ce0ad061abf35a2d2a1ca517ff35e87c3703dcdece72ef544531"} 01:46:15 INFO - Running post-run listener: copy_logs_to_upload_dir 01:46:15 INFO - Copying logs to upload dir... 01:46:15 INFO - mkdir: /builds/slave/test/build/upload/logs 01:46:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.226098 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-24 01:46:14.544014) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 01:46:14.547249) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556 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/Mozilla-Aurora/sha512/6ef61d8d081b91554c152b8fdfa51d5c798a3e577128709b409a62c748258df72bb7ca4f75520f5a5ef3f3ebce4f327acb112527bc7c3f30773a82a7d4d0f7b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38737c62bc0d7f277151738622578aa495a6bf6c530b70163a058b5fba98a276a15778a4e2d7ce0ad061abf35a2d2a1ca517ff35e87c3703dcdece72ef544531"} build_url:https://queue.taskcluster.net/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011148 build_url: 'https://queue.taskcluster.net/v1/task/I1f2JS11QwO4DgyNKs8WWQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ef61d8d081b91554c152b8fdfa51d5c798a3e577128709b409a62c748258df72bb7ca4f75520f5a5ef3f3ebce4f327acb112527bc7c3f30773a82a7d4d0f7b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38737c62bc0d7f277151738622578aa495a6bf6c530b70163a058b5fba98a276a15778a4e2d7ce0ad061abf35a2d2a1ca517ff35e87c3703dcdece72ef544531"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 01:46:14.571774) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 01:46:14.572074) ========= 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=03627c79f6bb3d1578c4a402000001ba-1461479810.857995-1184029556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004408 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 01:46:14.654444) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 01:46:14.654775) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 01:46:14.655094) ========= ========= Total master_lag: 0.18 =========