builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1462585470.81 results: success (0) buildid: 20160506160946 builduid: 209459d8cf2747b3b591f0d202dc4a09 revision: 0f66fd75014070ca82ddb8867bb85152d3d42484 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:30.809835) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:30.810353) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:30.810637) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:30.826790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:30.827046) ========= 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=0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 18:44:31-- 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% 46.5M=0s 2016-05-06 18:44:31 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102286 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:30.942624) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:30.942925) ========= 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=0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020271 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:30.992779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:30.993087) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0f66fd75014070ca82ddb8867bb85152d3d42484 --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 0f66fd75014070ca82ddb8867bb85152d3d42484 --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=0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 18:44:31,564 truncating revision to first 12 chars 2016-05-06 18:44:31,564 Setting DEBUG logging. 2016-05-06 18:44:31,564 attempt 1/10 2016-05-06 18:44:31,564 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0f66fd750140?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 18:44:32,035 unpacking tar archive at: mozilla-aurora-0f66fd750140/testing/mozharness/ program finished with exit code 0 elapsedTime=0.772154 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:31.777251) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:31.777534) ========= script_repo_revision: 0f66fd75014070ca82ddb8867bb85152d3d42484 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:31.777891) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:31.778153) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 18:44:31.788358) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2016-05-06 18:44:31.788637) ========= /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=0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:44:32 INFO - MultiFileLogger online at 20160506 18:44:32 in /builds/slave/test 18:44:32 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 18:44:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:44:32 INFO - {'append_to_log': False, 18:44:32 INFO - 'base_work_dir': '/builds/slave/test', 18:44:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:44:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:44:32 INFO - 'branch': 'Mozilla-Aurora', 18:44:32 INFO - 'buildbot_json_path': 'buildprops.json', 18:44:32 INFO - 'config_files': ('talos/linux_config.py',), 18:44:32 INFO - 'default_actions': ('clobber', 18:44:32 INFO - 'read-buildbot-config', 18:44:32 INFO - 'download-and-extract', 18:44:32 INFO - 'populate-webroot', 18:44:32 INFO - 'create-virtualenv', 18:44:32 INFO - 'install', 18:44:32 INFO - 'run-tests'), 18:44:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:44:32 INFO - 'download_minidump_stackwalk': True, 18:44:32 INFO - 'download_symbols': 'ondemand', 18:44:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:44:32 INFO - 'tooltool.py': '/tools/tooltool.py', 18:44:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:44:32 INFO - '/tools/misc-python/virtualenv.py')}, 18:44:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:44:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:44:32 INFO - 'installer_path': 'installer.exe', 18:44:32 INFO - 'log_level': 'info', 18:44:32 INFO - 'log_name': 'talos', 18:44:32 INFO - 'log_to_console': True, 18:44:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:44:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:44:32 INFO - 'opt_config_files': (), 18:44:32 INFO - 'pip_index': False, 18:44:32 INFO - 'sps_profile': False, 18:44:32 INFO - 'sps_profile_interval': 0, 18:44:32 INFO - 'suite': 'dromaeojs-e10s', 18:44:32 INFO - 'system_bits': '32', 18:44:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:44:32 INFO - 'title': 'talos-linux64-ix-029', 18:44:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:44:32 INFO - 'use_talos_json': True, 18:44:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:44:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:44:32 INFO - 'work_dir': 'build'} 18:44:32 INFO - ##### 18:44:32 INFO - ##### Running clobber step. 18:44:32 INFO - ##### 18:44:32 INFO - Running pre-action listener: _resource_record_pre_action 18:44:32 INFO - Running main action method: clobber 18:44:32 INFO - rmtree: /builds/slave/test/build 18:44:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:44:33 INFO - Running post-action listener: _resource_record_post_action 18:44:33 INFO - ##### 18:44:33 INFO - ##### Running read-buildbot-config step. 18:44:33 INFO - ##### 18:44:33 INFO - Running pre-action listener: _resource_record_pre_action 18:44:33 INFO - Running main action method: read_buildbot_config 18:44:33 INFO - Using buildbot properties: 18:44:33 INFO - { 18:44:33 INFO - "project": "", 18:44:33 INFO - "product": "firefox", 18:44:33 INFO - "script_repo_revision": "production", 18:44:33 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 18:44:33 INFO - "repository": "", 18:44:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 18:44:33 INFO - "buildid": "20160506160946", 18:44:33 INFO - "pgo_build": "True", 18:44:33 INFO - "basedir": "/builds/slave/test", 18:44:33 INFO - "buildnumber": 294, 18:44:33 INFO - "slavename": "talos-linux64-ix-029", 18:44:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:44:33 INFO - "platform": "ubuntu64_hw", 18:44:33 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:44:33 INFO - "branch": "mozilla-aurora", 18:44:33 INFO - "repo_path": "releases/mozilla-aurora", 18:44:33 INFO - "revision": "0f66fd75014070ca82ddb8867bb85152d3d42484", 18:44:33 INFO - "stage_platform": "linux64-pgo", 18:44:33 INFO - "builduid": "209459d8cf2747b3b591f0d202dc4a09", 18:44:33 INFO - "slavebuilddir": "test" 18:44:33 INFO - } 18:44:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 18:44:33 INFO - Running post-action listener: _resource_record_post_action 18:44:33 INFO - ##### 18:44:33 INFO - ##### Running download-and-extract step. 18:44:33 INFO - ##### 18:44:33 INFO - Running pre-action listener: _resource_record_pre_action 18:44:33 INFO - Running main action method: download_and_extract 18:44:33 INFO - mkdir: /builds/slave/test/build/tests 18:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:33 INFO - https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:44:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 18:44:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 18:44:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 18:44:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:44:42 INFO - Downloaded 1361 bytes. 18:44:42 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 18:44:42 INFO - Using the following test package requirements: 18:44:42 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 18:44:42 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:44:42 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:44:42 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:42 INFO - u'jsshell-linux-x86_64.zip'], 18:44:42 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:44:42 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 18:44:42 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:44:42 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:44:42 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:44:42 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 18:44:42 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:44:42 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:42 INFO - https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:44:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 18:44:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 18:44:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 18:44:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:44:43 INFO - Downloaded 23798585 bytes. 18:44:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:44:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:44:44 INFO - Return code: 0 18:44:44 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:44: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')]} 18:44:44 INFO - https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:44:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 18:44:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 18:44:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 18:44:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:44:46 INFO - Downloaded 23798585 bytes. 18:44:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:44:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:44:47 INFO - Return code: 0 18:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:47 INFO - https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:44:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 18:44:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 18:44:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 18:44:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:44:48 INFO - Downloaded 10840145 bytes. 18:44:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:44:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:44:48 INFO - Return code: 0 18:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:48 INFO - https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:44:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 18:44:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 18:44:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 18:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:44:50 INFO - Downloaded 62717137 bytes. 18:44:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 18:44:50 INFO - mkdir: /builds/slave/test/properties 18:44:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:44:50 INFO - Writing to file /builds/slave/test/properties/build_url 18:44:50 INFO - Contents: 18:44:50 INFO - build_url:https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 18:44:50 INFO - Running post-action listener: _resource_record_post_action 18:44:50 INFO - Running post-action listener: set_extra_try_arguments 18:44:50 INFO - ##### 18:44:50 INFO - ##### Running populate-webroot step. 18:44:50 INFO - ##### 18:44:50 INFO - Running pre-action listener: _resource_record_pre_action 18:44:50 INFO - Running main action method: populate_webroot 18:44:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:44:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:44:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:44:50 INFO - '--tppagecycles', 18:44:50 INFO - '7'], 18:44:50 INFO - 'tests': ['tsvgm']}}, 18:44:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:44:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:44:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:44:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:44:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:44:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:44:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:50 INFO - 'talos_options': ['--disable-e10s'], 18:44:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:44:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:44:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:50 INFO - 'talos_options': ['--disable-e10s'], 18:44:50 INFO - 'tests': ['damp', 'tps']}, 18:44:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:50 INFO - 'tests': ['damp', 'tps']}, 18:44:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:44:50 INFO - 'tests': ['dromaeo_dom']}, 18:44:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:44:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:44:50 INFO - 'tests': ['a11yr', 18:44:50 INFO - 'ts_paint', 18:44:50 INFO - 'tpaint', 18:44:50 INFO - 'sessionrestore', 18:44:50 INFO - 'sessionrestore_no_auto_restore', 18:44:50 INFO - 'tabpaint']}, 18:44:50 INFO - 'other-e10s': {'tests': ['a11yr', 18:44:50 INFO - 'ts_paint', 18:44:50 INFO - 'tpaint', 18:44:50 INFO - 'sessionrestore', 18:44:50 INFO - 'sessionrestore_no_auto_restore', 18:44:50 INFO - 'tabpaint']}, 18:44:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:44:50 INFO - 'ts_paint', 18:44:50 INFO - 'tpaint', 18:44:50 INFO - 'sessionrestore', 18:44:50 INFO - 'sessionrestore_no_auto_restore', 18:44:50 INFO - 'tabpaint']}, 18:44:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:44:50 INFO - 'ts_paint', 18:44:50 INFO - 'tpaint', 18:44:50 INFO - 'sessionrestore', 18:44:50 INFO - 'sessionrestore_no_auto_restore', 18:44:50 INFO - 'tabpaint']}, 18:44:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:44:50 INFO - 'tests': ['a11yr', 18:44:50 INFO - 'ts_paint', 18:44:50 INFO - 'tpaint', 18:44:50 INFO - 'sessionrestore', 18:44:50 INFO - 'sessionrestore_no_auto_restore', 18:44:50 INFO - 'tabpaint']}, 18:44:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:44:50 INFO - 'tests': ['a11yr', 18:44:50 INFO - 'ts_paint', 18:44:50 INFO - 'tpaint', 18:44:50 INFO - 'sessionrestore', 18:44:50 INFO - 'sessionrestore_no_auto_restore', 18:44:50 INFO - 'tabpaint']}, 18:44:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:44:50 INFO - 'tests': ['tsvgx', 18:44:50 INFO - 'tsvgr_opacity', 18:44:50 INFO - 'tart', 18:44:50 INFO - 'tscrollx', 18:44:50 INFO - 'cart']}, 18:44:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:44:50 INFO - 'tsvgr_opacity', 18:44:50 INFO - 'tart', 18:44:50 INFO - 'tscrollx', 18:44:50 INFO - 'cart']}, 18:44:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:50 INFO - 'talos_options': ['--disable-e10s'], 18:44:50 INFO - 'tests': ['tp5o']}, 18:44:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:50 INFO - 'tests': ['tp5o']}, 18:44:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:50 INFO - 'talos_options': ['--disable-e10s', 18:44:50 INFO - '--xperf_path', 18:44:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:44:50 INFO - 'tests': ['tp5n']}, 18:44:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:50 INFO - 'talos_options': ['--xperf_path', 18:44:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:44:50 INFO - 'tests': ['tp5n']}}, 18:44:50 INFO - 'talos.zip': {'path': '', 18:44:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:44:50 INFO - Running post-action listener: _resource_record_post_action 18:44:50 INFO - ##### 18:44:50 INFO - ##### Running create-virtualenv step. 18:44:50 INFO - ##### 18:44:50 INFO - Running pre-action listener: _resource_record_pre_action 18:44:50 INFO - Running main action method: create_virtualenv 18:44:50 INFO - Creating virtualenv /builds/slave/test/build/venv 18:44:50 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 18:44:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:44:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:44:50 INFO - Using real prefix '/usr' 18:44:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:44:51 INFO - Installing distribute.............................................................................................................................................................................................done. 18:44:53 INFO - Installing pip.................done. 18:44:53 INFO - Return code: 0 18:44:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f580db34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70410>, '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 0xd71310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd717a0>, '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': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', '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 18:44:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:44:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:44:53 INFO - Using env: {'DISPLAY': ':0', 18:44:53 INFO - 'HOME': '/home/cltbld', 18:44:53 INFO - 'LANG': 'en_US.UTF-8', 18:44:53 INFO - 'LANGUAGE': 'en_US:en', 18:44:53 INFO - 'LOGNAME': 'cltbld', 18:44:53 INFO - 'MAIL': '/var/mail/cltbld', 18:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:53 INFO - 'MOZ_NO_REMOTE': '1', 18:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:53 INFO - 'NO_EM_RESTART': '1', 18:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:53 INFO - 'PWD': '/builds/slave/test', 18:44:53 INFO - 'SHELL': '/bin/bash', 18:44:53 INFO - 'SHLVL': '1', 18:44:53 INFO - 'TERM': 'linux', 18:44:53 INFO - 'TMOUT': '86400', 18:44:53 INFO - 'USER': 'cltbld', 18:44:53 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', 18:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:53 INFO - '_': '/tools/buildbot/bin/python'} 18:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:44:53 INFO - Cleaning up... 18:44:53 INFO - Return code: 0 18:44:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f580db34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70410>, '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 0xd71310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd717a0>, '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': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', '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 18:44:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:44:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:44:53 INFO - Using env: {'DISPLAY': ':0', 18:44:53 INFO - 'HOME': '/home/cltbld', 18:44:53 INFO - 'LANG': 'en_US.UTF-8', 18:44:53 INFO - 'LANGUAGE': 'en_US:en', 18:44:53 INFO - 'LOGNAME': 'cltbld', 18:44:53 INFO - 'MAIL': '/var/mail/cltbld', 18:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:53 INFO - 'MOZ_NO_REMOTE': '1', 18:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:53 INFO - 'NO_EM_RESTART': '1', 18:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:53 INFO - 'PWD': '/builds/slave/test', 18:44:53 INFO - 'SHELL': '/bin/bash', 18:44:53 INFO - 'SHLVL': '1', 18:44:53 INFO - 'TERM': 'linux', 18:44:53 INFO - 'TMOUT': '86400', 18:44:53 INFO - 'USER': 'cltbld', 18:44:53 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', 18:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:53 INFO - '_': '/tools/buildbot/bin/python'} 18:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:53 INFO - Downloading/unpacking psutil>=0.7.1 18:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:44:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:44:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:44:55 INFO - Installing collected packages: psutil 18:44:55 INFO - Running setup.py install for psutil 18:44:55 INFO - building 'psutil._psutil_linux' extension 18:44:55 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 18:44:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:44:56 INFO - building 'psutil._psutil_posix' extension 18:44:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:44:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:44:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:44:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:44:56 INFO - Successfully installed psutil 18:44:56 INFO - Cleaning up... 18:44:56 INFO - Return code: 0 18:44:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f580db34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70410>, '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 0xd71310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd717a0>, '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': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', '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 18:44:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:44:56 INFO - Using env: {'DISPLAY': ':0', 18:44:56 INFO - 'HOME': '/home/cltbld', 18:44:56 INFO - 'LANG': 'en_US.UTF-8', 18:44:56 INFO - 'LANGUAGE': 'en_US:en', 18:44:56 INFO - 'LOGNAME': 'cltbld', 18:44:56 INFO - 'MAIL': '/var/mail/cltbld', 18:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:56 INFO - 'MOZ_NO_REMOTE': '1', 18:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:56 INFO - 'NO_EM_RESTART': '1', 18:44:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:56 INFO - 'PWD': '/builds/slave/test', 18:44:56 INFO - 'SHELL': '/bin/bash', 18:44:56 INFO - 'SHLVL': '1', 18:44:56 INFO - 'TERM': 'linux', 18:44:56 INFO - 'TMOUT': '86400', 18:44:56 INFO - 'USER': 'cltbld', 18:44:56 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', 18:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:56 INFO - '_': '/tools/buildbot/bin/python'} 18:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:44:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:44:58 INFO - Installing collected packages: mozsystemmonitor 18:44:58 INFO - Running setup.py install for mozsystemmonitor 18:44:58 INFO - Successfully installed mozsystemmonitor 18:44:58 INFO - Cleaning up... 18:44:58 INFO - Return code: 0 18:44:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:44: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')]} 18:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44: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')]} 18:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f580db34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70410>, '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 0xd71310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd717a0>, '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': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', '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 18:44:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:44:58 INFO - Using env: {'DISPLAY': ':0', 18:44:58 INFO - 'HOME': '/home/cltbld', 18:44:58 INFO - 'LANG': 'en_US.UTF-8', 18:44:58 INFO - 'LANGUAGE': 'en_US:en', 18:44:58 INFO - 'LOGNAME': 'cltbld', 18:44:58 INFO - 'MAIL': '/var/mail/cltbld', 18:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:58 INFO - 'MOZ_NO_REMOTE': '1', 18:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:58 INFO - 'NO_EM_RESTART': '1', 18:44:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:58 INFO - 'PWD': '/builds/slave/test', 18:44:58 INFO - 'SHELL': '/bin/bash', 18:44:58 INFO - 'SHLVL': '1', 18:44:58 INFO - 'TERM': 'linux', 18:44:58 INFO - 'TMOUT': '86400', 18:44:58 INFO - 'USER': 'cltbld', 18:44:58 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', 18:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:58 INFO - '_': '/tools/buildbot/bin/python'} 18:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:58 INFO - Downloading/unpacking blobuploader==1.2.4 18:44:58 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 18:44:58 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 18:44:58 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 18:44:58 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 18:44:58 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 18:44:58 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 18:45:00 INFO - Downloading blobuploader-1.2.4.tar.gz 18:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:45:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:45:00 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 18:45:00 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 18:45:00 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 18:45:00 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 18:45:00 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 18:45:00 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 18:45:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:45:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:01 INFO - Downloading docopt-0.6.1.tar.gz 18:45:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:45:01 INFO - Installing collected packages: blobuploader, requests, docopt 18:45:01 INFO - Running setup.py install for blobuploader 18:45:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:45:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:45:01 INFO - Running setup.py install for requests 18:45:01 INFO - Running setup.py install for docopt 18:45:02 INFO - Successfully installed blobuploader requests docopt 18:45:02 INFO - Cleaning up... 18:45:02 INFO - Return code: 0 18:45:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f580db34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70410>, '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 0xd71310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd717a0>, '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': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', '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 18:45:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:45:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:45:02 INFO - Using env: {'DISPLAY': ':0', 18:45:02 INFO - 'HOME': '/home/cltbld', 18:45:02 INFO - 'LANG': 'en_US.UTF-8', 18:45:02 INFO - 'LANGUAGE': 'en_US:en', 18:45:02 INFO - 'LOGNAME': 'cltbld', 18:45:02 INFO - 'MAIL': '/var/mail/cltbld', 18:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:02 INFO - 'MOZ_NO_REMOTE': '1', 18:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:02 INFO - 'NO_EM_RESTART': '1', 18:45:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:02 INFO - 'PWD': '/builds/slave/test', 18:45:02 INFO - 'SHELL': '/bin/bash', 18:45:02 INFO - 'SHLVL': '1', 18:45:02 INFO - 'TERM': 'linux', 18:45:02 INFO - 'TMOUT': '86400', 18:45:02 INFO - 'USER': 'cltbld', 18:45:02 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', 18:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:02 INFO - '_': '/tools/buildbot/bin/python'} 18:45:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:45:02 INFO - Running setup.py (path:/tmp/pip-x3_qD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:45:02 INFO - Running setup.py (path:/tmp/pip-WjX6Vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:45:02 INFO - Running setup.py (path:/tmp/pip-a5k_k0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:45:02 INFO - Running setup.py (path:/tmp/pip-cGBpw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:45:02 INFO - Running setup.py (path:/tmp/pip-ktFpqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:45:02 INFO - Running setup.py (path:/tmp/pip-EbFS3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:45:02 INFO - Running setup.py (path:/tmp/pip-8yMvDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:45:02 INFO - Running setup.py (path:/tmp/pip-tCocxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:45:02 INFO - Running setup.py (path:/tmp/pip-aJIlV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:45:02 INFO - Running setup.py (path:/tmp/pip-LhQhWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:45:03 INFO - Running setup.py (path:/tmp/pip-n2248F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:45:03 INFO - Running setup.py (path:/tmp/pip-M_jP3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:45:03 INFO - Running setup.py (path:/tmp/pip-G0XY8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:45:03 INFO - Running setup.py (path:/tmp/pip-Aiq7PF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:03 INFO - Running setup.py (path:/tmp/pip-oSBBrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:45:03 INFO - Running setup.py (path:/tmp/pip-tzlvwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:45:03 INFO - Running setup.py (path:/tmp/pip-7lmBap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:45:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:45:03 INFO - Running setup.py install for manifestparser 18:45:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:45:03 INFO - Running setup.py install for mozcrash 18:45:03 INFO - Running setup.py install for mozdebug 18:45:03 INFO - Running setup.py install for mozdevice 18:45:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:45:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:45:03 INFO - Running setup.py install for mozfile 18:45:04 INFO - Running setup.py install for mozhttpd 18:45:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Running setup.py install for mozinfo 18:45:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Running setup.py install for mozInstall 18:45:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Running setup.py install for mozleak 18:45:04 INFO - Running setup.py install for mozlog 18:45:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Running setup.py install for moznetwork 18:45:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Running setup.py install for mozprocess 18:45:04 INFO - Running setup.py install for mozprofile 18:45:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:45:04 INFO - Running setup.py install for mozrunner 18:45:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Running setup.py install for mozscreenshot 18:45:05 INFO - Running setup.py install for moztest 18:45:05 INFO - Running setup.py install for mozversion 18:45:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:45:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:45:05 INFO - Cleaning up... 18:45:05 INFO - Return code: 0 18:45:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f580db34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70410>, '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 0xd71310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd717a0>, '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': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', '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 18:45:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:45:05 INFO - Using env: {'DISPLAY': ':0', 18:45:05 INFO - 'HOME': '/home/cltbld', 18:45:05 INFO - 'LANG': 'en_US.UTF-8', 18:45:05 INFO - 'LANGUAGE': 'en_US:en', 18:45:05 INFO - 'LOGNAME': 'cltbld', 18:45:05 INFO - 'MAIL': '/var/mail/cltbld', 18:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:05 INFO - 'MOZ_NO_REMOTE': '1', 18:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:05 INFO - 'NO_EM_RESTART': '1', 18:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:05 INFO - 'PWD': '/builds/slave/test', 18:45:05 INFO - 'SHELL': '/bin/bash', 18:45:05 INFO - 'SHLVL': '1', 18:45:05 INFO - 'TERM': 'linux', 18:45:05 INFO - 'TMOUT': '86400', 18:45:05 INFO - 'USER': 'cltbld', 18:45:05 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', 18:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:05 INFO - '_': '/tools/buildbot/bin/python'} 18:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:45:05 INFO - Running setup.py (path:/tmp/pip-HlMSgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:45:05 INFO - Running setup.py (path:/tmp/pip-zxZqzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:45:05 INFO - Running setup.py (path:/tmp/pip-CG8KJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:45:05 INFO - Running setup.py (path:/tmp/pip-ADp_zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:45:05 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)) 18:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:45:05 INFO - Running setup.py (path:/tmp/pip-V6Xes3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:45:05 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)) 18:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:45:05 INFO - Running setup.py (path:/tmp/pip-xL087U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:45:06 INFO - Running setup.py (path:/tmp/pip-Csv_ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:45:06 INFO - Running setup.py (path:/tmp/pip-ddRjtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:45:06 INFO - Running setup.py (path:/tmp/pip-BzuDMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:45:06 INFO - Running setup.py (path:/tmp/pip-glxO3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:45:06 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)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:45:06 INFO - Running setup.py (path:/tmp/pip-v6iN5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:45:06 INFO - Running setup.py (path:/tmp/pip-1EdJ4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:45:06 INFO - Running setup.py (path:/tmp/pip-gsfYah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:45:06 INFO - Running setup.py (path:/tmp/pip-vF43w0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:06 INFO - Running setup.py (path:/tmp/pip-KsrEEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:45:06 INFO - Running setup.py (path:/tmp/pip-4lghB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:45:06 INFO - Running setup.py (path:/tmp/pip-Ja8qzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:45:06 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)) 18:45:06 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)) 18:45:06 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)) 18:45:06 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)) 18:45:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:45:06 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 18:45:06 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 18:45:06 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 18:45:06 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 18:45:06 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 18:45:06 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 18:45:08 INFO - Downloading blessings-1.6.tar.gz 18:45:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:45:08 INFO - Installing collected packages: blessings 18:45:08 INFO - Running setup.py install for blessings 18:45:08 INFO - Successfully installed blessings 18:45:08 INFO - Cleaning up... 18:45:08 INFO - Return code: 0 18:45:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:45:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:45:09 INFO - Reading from file tmpfile_stdout 18:45:09 INFO - Current package versions: 18:45:09 INFO - argparse == 1.2.1 18:45:09 INFO - blessings == 1.6 18:45:09 INFO - blobuploader == 1.2.4 18:45:09 INFO - docopt == 0.6.1 18:45:09 INFO - manifestparser == 1.1 18:45:09 INFO - mozInstall == 1.12 18:45:09 INFO - mozcrash == 0.17 18:45:09 INFO - mozdebug == 0.1 18:45:09 INFO - mozdevice == 0.48 18:45:09 INFO - mozfile == 1.2 18:45:09 INFO - mozhttpd == 0.7 18:45:09 INFO - mozinfo == 0.9 18:45:09 INFO - mozleak == 0.1 18:45:09 INFO - mozlog == 3.1 18:45:09 INFO - moznetwork == 0.27 18:45:09 INFO - mozprocess == 0.22 18:45:09 INFO - mozprofile == 0.28 18:45:09 INFO - mozrunner == 6.11 18:45:09 INFO - mozscreenshot == 0.1 18:45:09 INFO - mozsystemmonitor == 0.0 18:45:09 INFO - moztest == 0.7 18:45:09 INFO - mozversion == 1.4 18:45:09 INFO - psutil == 3.1.1 18:45:09 INFO - requests == 1.2.3 18:45:09 INFO - wsgiref == 0.1.2 18:45:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:45: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')]} 18:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45: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')]} 18:45:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f580db34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70410>, '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 0xd71310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd717a0>, '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': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', '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 18:45:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:45:09 INFO - Using env: {'DISPLAY': ':0', 18:45:09 INFO - 'HOME': '/home/cltbld', 18:45:09 INFO - 'LANG': 'en_US.UTF-8', 18:45:09 INFO - 'LANGUAGE': 'en_US:en', 18:45:09 INFO - 'LOGNAME': 'cltbld', 18:45:09 INFO - 'MAIL': '/var/mail/cltbld', 18:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:09 INFO - 'MOZ_NO_REMOTE': '1', 18:45:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:09 INFO - 'NO_EM_RESTART': '1', 18:45:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:09 INFO - 'PWD': '/builds/slave/test', 18:45:09 INFO - 'SHELL': '/bin/bash', 18:45:09 INFO - 'SHLVL': '1', 18:45:09 INFO - 'TERM': 'linux', 18:45:09 INFO - 'TMOUT': '86400', 18:45:09 INFO - 'USER': 'cltbld', 18:45:09 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', 18:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:09 INFO - '_': '/tools/buildbot/bin/python'} 18:45:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:45:09 INFO - Cleaning up... 18:45:09 INFO - Return code: 0 18:45:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:45: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')]} 18:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45: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')]} 18:45:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f580db34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70410>, '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 0xd71310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd717a0>, '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': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', '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 18:45:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:45:09 INFO - Using env: {'DISPLAY': ':0', 18:45:09 INFO - 'HOME': '/home/cltbld', 18:45:09 INFO - 'LANG': 'en_US.UTF-8', 18:45:09 INFO - 'LANGUAGE': 'en_US:en', 18:45:09 INFO - 'LOGNAME': 'cltbld', 18:45:09 INFO - 'MAIL': '/var/mail/cltbld', 18:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:09 INFO - 'MOZ_NO_REMOTE': '1', 18:45:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:09 INFO - 'NO_EM_RESTART': '1', 18:45:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:09 INFO - 'PWD': '/builds/slave/test', 18:45:09 INFO - 'SHELL': '/bin/bash', 18:45:09 INFO - 'SHLVL': '1', 18:45:09 INFO - 'TERM': 'linux', 18:45:09 INFO - 'TMOUT': '86400', 18:45:09 INFO - 'USER': 'cltbld', 18:45:09 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', 18:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:09 INFO - '_': '/tools/buildbot/bin/python'} 18:45:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:09 INFO - Downloading/unpacking jsonschema 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:45:11 INFO - Downloading/unpacking functools32 (from jsonschema) 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45: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 18:45:11 INFO - Downloading functools32-3.2.3-2.tar.gz 18:45:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:45:11 INFO - warning: no files found matching '*.txt' 18:45:11 INFO - no previously-included directories found matching 'build' 18:45:11 INFO - no previously-included directories found matching 'dist' 18:45:11 INFO - no previously-included directories found matching '.git*' 18:45:11 INFO - Installing collected packages: jsonschema, functools32 18:45:11 INFO - Running setup.py install for functools32 18:45:11 INFO - warning: no files found matching '*.txt' 18:45:11 INFO - no previously-included directories found matching 'build' 18:45:11 INFO - no previously-included directories found matching 'dist' 18:45:11 INFO - no previously-included directories found matching '.git*' 18:45:11 INFO - Successfully installed jsonschema functools32 18:45:11 INFO - Cleaning up... 18:45:11 INFO - Return code: 0 18:45:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:45:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:45:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:45:11 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 0x7f580db34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xce15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd70410>, '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 0xd71310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd717a0>, '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': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', '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 18:45:11 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 18:45:11 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 18:45:11 INFO - Using env: {'DISPLAY': ':0', 18:45:11 INFO - 'HOME': '/home/cltbld', 18:45:11 INFO - 'LANG': 'en_US.UTF-8', 18:45:11 INFO - 'LANGUAGE': 'en_US:en', 18:45:11 INFO - 'LOGNAME': 'cltbld', 18:45:11 INFO - 'MAIL': '/var/mail/cltbld', 18:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:11 INFO - 'MOZ_NO_REMOTE': '1', 18:45:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:11 INFO - 'NO_EM_RESTART': '1', 18:45:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:11 INFO - 'PWD': '/builds/slave/test', 18:45:11 INFO - 'SHELL': '/bin/bash', 18:45:11 INFO - 'SHLVL': '1', 18:45:11 INFO - 'TERM': 'linux', 18:45:11 INFO - 'TMOUT': '86400', 18:45:11 INFO - 'USER': 'cltbld', 18:45:11 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', 18:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:11 INFO - '_': '/tools/buildbot/bin/python'} 18:45:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:45:12 INFO - Downloading/unpacking flake8 18:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:45:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:45:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:45:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:45:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:45:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:45:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:45:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:45:14 INFO - no previously-included directories found matching 'docs/_build' 18:45:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:45:14 INFO - Running setup.py install for pep8 18:45:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:45:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:45:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:45:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:45:14 INFO - no previously-included directories found matching 'docs/_build' 18:45:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:45:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:45:14 INFO - Cleaning up... 18:45:15 INFO - Return code: 0 18:45:15 INFO - Running post-action listener: _resource_record_post_action 18:45:15 INFO - Running post-action listener: _start_resource_monitoring 18:45:15 INFO - Starting resource monitoring. 18:45:15 INFO - ##### 18:45:15 INFO - ##### Running install step. 18:45:15 INFO - ##### 18:45:15 INFO - Running pre-action listener: _resource_record_pre_action 18:45:15 INFO - Running main action method: install 18:45:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:45:15 INFO - Reading from file tmpfile_stdout 18:45:15 INFO - Detecting whether we're running mozinstall >=1.0... 18:45:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:45:15 INFO - Reading from file tmpfile_stdout 18:45:15 INFO - Output received: 18:45:15 INFO - Usage: mozinstall [options] installer 18:45:15 INFO - Options: 18:45:15 INFO - -h, --help show this help message and exit 18:45:15 INFO - -d DEST, --destination=DEST 18:45:15 INFO - Directory to install application into. [default: 18:45:15 INFO - "/builds/slave/test"] 18:45:15 INFO - --app=APP Application being installed. [default: firefox] 18:45:15 INFO - mkdir: /builds/slave/test/build/application 18:45:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:45:30 INFO - Reading from file tmpfile_stdout 18:45:30 INFO - Output received: 18:45:30 INFO - /builds/slave/test/build/application/firefox/firefox 18:45:30 INFO - Running post-action listener: _resource_record_post_action 18:45:30 INFO - ##### 18:45:30 INFO - ##### Running run-tests step. 18:45:30 INFO - ##### 18:45:30 INFO - Running pre-action listener: _resource_record_pre_action 18:45:30 INFO - Running main action method: run_tests 18:45:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:45:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:45:30 INFO - Python 2.7.3 18:45:30 INFO - Return code: 0 18:45:30 INFO - grabbing minidump binary from tooltool 18:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:30 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 0xd70410>, '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 0xd71310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd717a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:45:30 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 18:45:30 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 18:45:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:45:30 INFO - Return code: 0 18:45:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:45:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:45:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:45:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:45:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:45:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:45:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:45:31 INFO - Return code: 0 18:45:31 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/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 18:45:31 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/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 18:45:31 INFO - Using env: {'DISPLAY': ':0', 18:45:31 INFO - 'HOME': '/home/cltbld', 18:45:31 INFO - 'LANG': 'en_US.UTF-8', 18:45:31 INFO - 'LANGUAGE': 'en_US:en', 18:45:31 INFO - 'LOGNAME': 'cltbld', 18:45:31 INFO - 'MAIL': '/var/mail/cltbld', 18:45:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:45:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:31 INFO - 'MOZ_NO_REMOTE': '1', 18:45:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:31 INFO - 'NO_EM_RESTART': '1', 18:45:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:31 INFO - 'PWD': '/builds/slave/test', 18:45:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:45:31 INFO - 'SHELL': '/bin/bash', 18:45:31 INFO - 'SHLVL': '1', 18:45:31 INFO - 'TERM': 'linux', 18:45:31 INFO - 'TMOUT': '86400', 18:45:31 INFO - 'USER': 'cltbld', 18:45:31 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005', 18:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:31 INFO - '_': '/tools/buildbot/bin/python'} 18:45:31 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/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 18:45:32 INFO - mozversion application_buildid: 20160506160946 18:45:32 INFO - mozversion application_changeset: 0f66fd75014070ca82ddb8867bb85152d3d42484 18:45:32 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:45:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:45:32 INFO - mozversion application_name: Firefox 18:45:32 INFO - mozversion application_remotingname: firefox-dev 18:45:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:45:32 INFO - mozversion application_vendor: Mozilla 18:45:32 INFO - mozversion application_version: 48.0a2 18:45:32 INFO - mozversion platform_buildid: 20160506160946 18:45:32 INFO - mozversion platform_changeset: 0f66fd75014070ca82ddb8867bb85152d3d42484 18:45:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:45:32 INFO - mozversion platform_version: 48.0a2 18:45:32 INFO - using testdate: 1462585532 18:45:32 INFO - actual date: 1462585532 18:45:32 INFO - starting webserver on 'localhost:55343' 18:45:32 INFO - SUITE-START | Running 2 tests 18:45:32 INFO - TEST-START | dromaeo_css 18:45:32 INFO - operating with platform_type : linux_ 18:45:32 INFO - Initialising browser for dromaeo_css test... 18:45:32 INFO - TEST-INFO | started process 27045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKOVwJV/profile http://localhost:55343/getInfo.html) 18:45:35 INFO - PROCESS | 27045 | 18:45:35 INFO - PROCESS | 27045 | (process:27127): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:45:36 INFO - PROCESS | 27045 | __metrics Screen width/height:1600/1200 18:45:36 INFO - PROCESS | 27045 | colorDepth:24 18:45:36 INFO - PROCESS | 27045 | Browser inner width/height: 1024/697 18:45:36 INFO - PROCESS | 27045 | __metrics 18:45:36 ERROR - PROCESS | 27045 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 18:45:37 INFO - TEST-INFO | 27045: exit 0 18:45:37 INFO - Browser initialized. 18:45:37 INFO - Running cycle 1/1 for dromaeo_css test... 18:45:37 INFO - TEST-INFO | started process 27178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKOVwJV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:45:39 INFO - PROCESS | 27178 | 18:45:39 INFO - PROCESS | 27178 | (process:27249): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:45:49 INFO - PROCESS | 27178 | RSS: Main: 152371200 18:45:49 INFO - PROCESS | 27178 | 18:46:39 INFO - PROCESS | 27178 | 1462585599009 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] 18:48:46 INFO - PROCESS | 27178 | Cycle 1(1): loaded http://localhost:55343/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55343/tests/dromaeo/cssquery-ext.html) 18:48:47 INFO - PROCESS | 27178 | RSS: Main: 155578368 18:48:47 INFO - PROCESS | 27178 | 18:51:49 INFO - PROCESS | 27178 | Cycle 1(1): loaded http://localhost:55343/tests/dromaeo/cssquery-ext.html (next: http://localhost:55343/tests/dromaeo/cssquery-jquery.html) 18:51:50 INFO - PROCESS | 27178 | RSS: Main: 153890816 18:51:50 INFO - PROCESS | 27178 | 18:54:52 INFO - PROCESS | 27178 | Cycle 1(1): loaded http://localhost:55343/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55343/tests/dromaeo/cssquery-mootools.html) 18:54:52 INFO - PROCESS | 27178 | RSS: Main: 153657344 18:54:52 INFO - PROCESS | 27178 | 18:57:54 INFO - PROCESS | 27178 | Cycle 1(1): loaded http://localhost:55343/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55343/tests/dromaeo/cssquery-prototype.html) 18:57:54 INFO - PROCESS | 27178 | RSS: Main: 153530368 18:57:54 INFO - PROCESS | 27178 | 19:00:57 INFO - PROCESS | 27178 | Cycle 1(1): loaded http://localhost:55343/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55343/tests/dromaeo/cssquery-yui.html) 19:00:57 INFO - PROCESS | 27178 | RSS: Main: 154656768 19:00:57 INFO - PROCESS | 27178 | 19:04:00 INFO - PROCESS | 27178 | Cycle 1(1): loaded http://localhost:55343/tests/dromaeo/cssquery-yui.html (next: http://localhost:55343/tests/dromaeo/cssquery-dojo.html) 19:04:00 INFO - PROCESS | 27178 | RSS: Main: 156594176 19:04:00 INFO - PROCESS | 27178 | 19:04:00 INFO - PROCESS | 27178 | __start_tp_report 19:04:00 INFO - PROCESS | 27178 | _x_x_mozilla_page_load 19:04:00 INFO - PROCESS | 27178 | _x_x_mozilla_page_load_details 19:04:00 INFO - PROCESS | 27178 | |i|pagename|runs| 19:04:00 INFO - PROCESS | 27178 | |0;dojo.html;3360.529525866379;3418.042947974567;3425.212201193724;3466.3413951349244;3476.5306683597723;5662.348829884564;5695.772169113241;5713.885722285552;5735.08238681811;5773.971130144343;5756.453136951994;5762.164486149506;5777.306723193223;5792.449717276862;5795.884082318351;5214.165733482653;5229.921551176735;5263.0526505229045;5296.073187192245;5300.337457817773;5073.264376665381;5206.843794686166;5379.38137114233;5385.892282154355;5402.945970540303;5256.973715131419;5284.4187139414635;5289.471052894718;5293.602979776532;5316.12283973144;5300.416954135042;5313.707746073965;5323.22813192087;5332.786688532454;5349.22436246742;4988.575971042465;5119.206522988943;5218.008578370098;5236.947630523684;5290.788368465257;5571.582131340125;5593.664380137205;5601.915971260434;5604.3835178130375;5663.1505274208785;6033.637981721067;6084.148219249309;6090.025595904678;6096.847578810521;6097.17688112108;5919.2009078774245;6045.969770151165;6123.069106197275;6154.169187159721;6166.414190651881;5742.052561327376;5746.454086861741;5752.798652047159;5761.9135712964335;5782.479576838063;6152.876942461216;6185.567010309325;6198.752049917953;6205.565610407319;6215;5957.6127551709;5996.550258730613;6092.634441933498;6121.479674227651;6135.969320153371;6121.081837724377;6137;6141.662208578571;6142.293636231891;6147.754089836357;5869.06095024794;6068.241469816273;6086.391360863879;6101.389861013952;6159.81520554384;6059.454649081604;6075.27096748393;6111.318268824403;6122.418370254819;6141.692915354304;4603.95396046042;4623.86128416148;4651.209294419957;4671.299305104194;4704.482506924235;4069.5116586009867;4128.298189307825;4147.232761939051;4168.874933751992;4191.287481128215;5677.943220567741;5760.942390576124;5817.418258174149;5870.5890587659305;5892.204552385373;6030;6050.3949605040025;6053.636781793107;6060.545459090586;6063.575549711478;5779.682117483495;5884.823455296348;5923.022701254331;5944.138099975479;5963.314218864886;5177.145770947826;5195.636305458657;5222.086134926372;5222.216667499905;5237.397699264558;5986.072158815304;6274.152989346379;6382.042693595998;6416.807495775134;6434.903476447857;6002.249718785152;6071.301800293023;6076.817695469143;6104.755809767559;6125;6137.009281402767;6324.367563243639;6334.6199228044625;6341.873162536631;6350.460210882126;5985.730642121028;6074.271087469532;6091.177691011657;6099.268087829489;6122.326544080237;6139;6145.877082458415;6152.692365381802;6162.291336496181;6172.321044685171;5865.73604187804;5942.64344139353;5988.311344195299;6016.939830601638;6017.15759793638;5966.582339236385;6023.397660233942;6041.6375017499095;6054.364291749479;6087.330393656783;5781.046127388934;5808.332041815076;5860.765569377178;5866.765329386777;5876.676782776988;5866.911996320144;5951.137085122719;5983.910241346296;5992.580519363602;6025.18659980897;5823.621464604787;5852.678102704222;5857.765689372377;5861.9413805863105;5901.439363260483 19:04:00 INFO - PROCESS | 27178 | |1;ext.html;645.183842439314;674.7098747538558;690.8376531515096;713.9107611548557;742.0390594180537;37186.44220336694;38161.42757858634;38182.61817381826;38550.228995420075;38570.421443678366;42719.35920961188;43590;43715.78142109293;43727;44005.7799711001;8836.513991730451;8959.955200223989;9046.095390460967;9083.318751093695;9091.727248182566;8912.465252084863;9012.909870901305;9026.368154229207;9028.097190280952;9036.367454278203;9003.5048072356;9046.638134474646;9052.456852588833;9056.049114842945;9065;8992.730218093468;9019.639214431414;9037.502937338444;9051.049639787794;9068.863967040466;8882.467051976837;8939.374243802871;8941.865872011926;8977.685780997634;9007.099290071006;39470.21059578821;39744.40383394252;39766.80116599399;39775.204495910206;39803;3746.1571146492092;3899.8742941516985;3920.274749171384;3942.2903877302074;4015.5181378234797;32354.352912941846;32429.6757032429;32549.83725081383;32702.182445438815;32754.181145471317;4548.385967894325;4557.498675145731;4659.998100408395;4663.251280769711;4673.742944138071;229481;230238;230313;230370;232348.83825580933;58540.707296463246;58678.11982820261;58930.70534647299;58946.70526647339;59035;68244.6587767058;69717;69920.3007969924;70193;70334.2966570338;18399.908000459913;18494.81505184931;18565.628687426175;18639.534011649816;18702.53243668919;13851;13985.160890346611;14000.439982400794;14014.789778153336;14099.929500352433;20221;20489.795102049087;20589.48526286825;20665.070071846803;20718.378448646567;7348.979030766582;7760.689572417153;7795.766127016199;7909.881351779728;7971.036145058242;1121.9551217951355;1153.1524329617723;1170.239344426113;1188.4592510407745;1217.5008246618843;32119.64693364748;32914.50628240578;33142;33311.83344083313;33793.15517112043;1168.807146820782;1218.7440637466232;1229.170310040719;1258.584667059868;1267.3916520070418;16553.337866485206;16565;16625.50123496297;16762.161891905354;16966.406175783788;499370;571737;574320;577578;947355;59171;59490.70254648699;60112;60118;60579.18262452134;1533.5322726568504;1545.0497943764728;1564.9843501565067;1569.2232344989304;1640.9989906157234;32592.185195370304;33025;33043.83478082594;33131;33717.157071073416;53028;53801.73099134479;53827.73086134701;53968.46031539791;54136.45863541472;456673;458768;461107;463188;464197;30147.698523015366;30330.39339213159;30554;30679.539806902467;30728.385432290783;48652.75673621751;48966.26550601672;49230.507694924025;49233.75383123061;49430.50569494259;38437.23125537529;38931.805340973115;39125;39193;39560.60439395569;40124.598754012084;40547;40884.79557602193;41583;41935.16129677328;41537;41916;41970;42236;42283;35648.821755891055;35748.821255893556;35899.641003590674;36252.456213157355;36370.63629363672;28586;28635.85568326891;28699.42153181595;28747.972962920023;28835.5674664876 19:04:00 INFO - PROCESS | 27178 | |2;jquery.html;426.2327809942103;427.88233235860156;430.1268425097053;436.9235383807834;441.63785695729496;18719.3448229312;19022.524436889085;19445.611087778238;20372;20893.268735594258;19704.310349137784;20097.29659461919;20140.194392224294;20300.390988270337;20315.18739250432;5537.501624853762;5672.914906276409;5813.854653633651;5814.273215848019;5817.301923769132;4006.9799651001704;5698.544116470694;5712.485876271135;5748.856278593027;5980.521558275327;5949.137375080611;5960.374160713128;5977.043673012319;5978.491828194608;5994.430529099728;5897.380775018625;5944.732487038072;6611.768588099393;6620.040094186316;6675.632840193787;5876.4123587641325;5886.08765641322;5902.793402230901;5917.993941030035;5925.2889653241455;14422.134671919614;18675.34636287737;21577.24479643205;23910.16314429004;24035.158769442987;2463.0517250858547;2553.59142537195;2587.2238328501376;2605.491929073831;2749.9450010999667;10047.799044019152;10138.442385668784;10670.466476676134;10680.305780124345;10731.946340268327;2009.2264478175862;2093.0685844799073;2104.2214380679247;2133.0614529606923;2145.238440353683;73143;79251.60374198091;79313;79991;80099.99999999942;11401.714957125972;11411.942940285411;11517.827232591519;11655.417229138679;11710.180287379802;16204.270807813677;16231.837681623269;16330.510084697478;16345.264463099189;16359.59101022484;8827.867581986275;8867.467951922905;8878.511681857432;8997.64009439615;9197.954010229905;8803.339749518811;8815.162559556831;8896.59965301563;8991.920969483574;9069.31980101495;4931.5561599455505;5008.4240312364545;5051.974740126349;5059.924101138486;5112.514311140436;2000.9399718008483;2046.5292982613785;2098.5802839432176;2140.3150991682824;2145.4100122466134;941.1059493481221;978.8189185000798;984.8670429491926;994.9005099489993;1070.9410982395887;16645.750313745302;17707.73438398425;18643.254269829325;19049.904750476435;19581;1032.210359075308;1065.3394895165047;1079.4225089577196;1123.1913022623698;1144.3019757947645;10092.34399764013;10790.89209107899;10827.404492752818;10855.67432977012;11069.446527673585;543394;548060;552206;571815;584322;91502;92495.53752231196;93356.53321733484;94925.5253723727;97576;1063.1335461598771;1091.9945400272948;1098.8681358237063;1099.8625171853519;1102.8897110288906;16828.495145145665;16944.237509312356;17131.657366852345;17206.22571984289;17321;40147.598524014385;40628.1874362517;41226.58773412227;41603.37594936139;41679;54133.72933135309;59568;60704;60942.39057609367;61331.693341533006;8761.561921904007;8783.472991620523;8953.686620968236;9258.888933327775;9357.53212339394;10226.181905447398;13807.723845522833;13992.230427326187;14054.464294630268;14059;11558.595449159238;11621.5351385947;11772.882271177179;11783.234089784137;12022.27866328023;11392.25950313227;11789.941050294694;11795.643500997496;11897.286162830258;12200.877991219973;11912.821307680219;11935.283882967049;11957.701057473632;11985.880141198477;12046.277223366626;8933.883264591926;9239.815203696024;9261.398009129385;9330.766730831783;9334.39326443779;11325.037371823488;11344.489497972776;11414.600488982845;11481.598144065252;11517.884821151682 19:04:00 INFO - PROCESS | 27178 | |3;mootools.html;1550.2248875562218;1601.6076061364963;1771.9911400442995;1895.412422149133;1908.3702378215191;7700.3454706349885;8374.874376884352;8572.914270857289;8803.559822008898;8808.603612837429;8309.044459887114;8332.83334333313;8344.290735287492;8363.581820908945;8409.075001749818;2427.8664673442954;2432.1852179519883;2445.7282213249186;2447.106806015809;2460.151247819508;2448.902043918241;2465.3713303107684;2487.2662564543502;2489.626556016594;2491.6511688363553;2429.331933718233;2474.2948259745976;2478.182199874046;2483.52812965536;2487.166799122296;2412.7587241275996;2416.2630397728685;2427.647991041307;2457.7173625032992;2471.0486462711806;2448.3144719478573;2449.35092200567;2488.154027630614;2489.825712200147;2522.3441905104805;8858.247049000842;8921.643134274622;8926.687565935226;8927.37508374414;8933.151350621745;5467.343918729778;5592.692401917893;5621.325440947113;5621.465960733764;5633.718314084279;3517.278957813642;3565.090901820045;3640.8907732767793;3643.763155394891;3649.543807024122;1114.509615769059;1118.2842980492492;1149.2127892393737;1151.7523732397574;1152.3028567716494;12487.687807804787;12508.124431289812;12552.748945021049;12562.68593285166;12589.055820813475;4956.207006878954;4988.927380613186;4992.600591952635;5103.8468845934685;5165.845024649267;10717.571297148026;10729.892701073046;10744.516496757664;10772.730681732863;10800.729981750363;5639.379668236573;5664.745086471119;5676.347220069662;5679.148127780783;5693.259876216065;4446.9777651111535;5036.722980236049;5042.420121686053;5109;5177.58579313654;4359.869203923888;4364.978175109104;4371.672124590668;4384.539623339567;4480.372747815309;1399.6990647010941;1422.5945605502588;1422.8292604887479;1439.8416174220827;1441.3730027438098;910.5356268303213;1039.443897514841;1072.6138590107555;1092.9726756830985;1097.401915955806;6163.753449862045;6445.967770161119;6454.19322584677;6495.6752162391695;6505;1003.3177439341318;1062.1131355318396;1098.8296813993843;1141.6689160143465;1142.0692135909208;4155.625993660585;4222.915541689149;4259.8083086261195;4281.550437204049;4291.2061268664775;10308.896911030944;10552.103071239031;10628.09661178793;10674.359538427563;10721.35671859691;10295.3822770634;10454.32046916948;10470;10519.579216831395;10533.262671612914;8088.11030786613;8137.837243255101;8345.457545259538;8436.620352084294;8476.194761497647;6290.433860952537;6304;6340.397662222082;6357.713902874474;6507.381798729113;9800.068993445611;9858.704238872846;9900.455474948947;10028.598856045677;10097.697069087939;9963.900360996297;10066.597336106473;10275;10445.373277603368;10451.790964180522;8007.838863364663;8141.14517975604;8156.062052863759;8192.75421737349;8201.22088401601;8627.91372086271;8674.869876951978;8695.565221738761;8711.39020268575;8729.607167677343;7758.224177582197;7987.16134805837;8041.477303975223;8099.554524501209;8108.108108107986;7604.733834315773;7637.694492220249;7724.652390642322;7920.643571039202;7927.445078844426;6770.187577490536;7307.41540676734;7345;7371.741989030358;7373.594452305175;5497.862553436036;5502.669839809624;5535.948169847716;5587.972060139836;5652.63257888236;5417.106177480671;5423.430539793423;5444.564434845282;5590.468905453975;5607.943920560905 19:04:00 INFO - PROCESS | 27178 | |4;prototype.html;362.7370156636437;364.8394706329215;371.44839912729594;375.5212104566675;376.6421899195765;6529.477641788658;6592.208934927809;6697.3302669733;6707.7987660370145;6745.763898263562;6677.298883617211;6710.16122984627;6761.729530818774;6769.323067693228;6769.898451523231;5065.316182315396;5075.5178258065425;5088.491150884919;5091.287219789232;5093.465186155456;5061.569766569846;5086.31334769805;5087.414947281054;5088.058709138802;5096.235564665293;5013;5048.747562621873;5052.368453943257;5052.696838189702;5054.418741844698;4797.184478638623;4938.308636790852;4940.4318503372215;5030.974845125787;5037.168867136937;4252.829886804555;4259.595338442843;4268.253055715269;4290.034742183015;4291.163223171483;6308.179936608258;6320.273168585625;6346.904796428057;6356.491480681534;6366.204224471941;5618.747156377973;5749.942500574983;5759.1937128802;5795.9420405796245;5796.942030579682;6999.5450295731125;7000.264972177899;7003.369696727268;7004.7548335808515;7006.614636195059;4742.834000809955;4749.1926372516755;4752.667313288071;4756.833510827139;4764.4282686077895;7283.344498995063;7315;7335.119785625706;7359.300866417681;7365.44759143061;4909;4942.431620363633;4962.9751851241235;4964.67729597575;5092.643514953992;5088.465711100355;5089.720065396365;5130.30740849988;5141.794328226829;5151.381834179922;5846.386129456431;5873.647581145145;5914.290285165722;5934.080217566284;5950.523958083343;7097.503174777819;7186.92813071873;7188.029616001772;7190.568565886064;7194.172670143001;1796.8562514998769;1821.5264031351944;1824.0241470813316;1824.771903512061;1825.0600940515644;1184.1592469346688;1187.9940600296943;1215.562397536886;1231.9260844349367;1240.1009268280604;6811.080504131978;6828.351306625962;6832.214295355998;6833.794986150423;6837.076994605664;7208.135023797178;7217.06178196831;7228.31331023552;7232.674529646179;7248.891266631004;6787.04981302618;6798.286179951133;6798.694058767367;6815.522913396015;6829;3875.108724993211;3896.59085795993;3928.3714605663527;3943.9014024649614;3965.365541513344;7521.623918804038;7550.131734850453;7563.508371955805;7579.279968402993;7598.278163574451;7318.597477138702;7319.926800731924;7360.447966402541;7365.1530074042175;7367.373773229336;7500.62496875165;7512.286332798375;7513.624318784039;7522.887156692654;7569.924300756922;7066.187388450188;7211.4230861532005;7224.819379515554;7240.710371585077;7245.746398876014;7104.573725576482;7133.785986420416;7135.072440582691;7142.107236595426;7152.284771522806;7550.7734767957045;7557.848843022999;7558.206388329366;7568.129665088585;7569.810754731176;5092.0579692756955;5118.692878427306;5125.205593133071;5132.871678208075;5141.074606570854;7074.893876591958;7207.747728829466;7212.386947109554;7224.674889629874;7226.927730722836;6965.756198533027;6996.825079373057;7009;7016.649167541705;7022.508424410242;6879.793606191823;6934.8613027740175;6934.930650693428;6950.374466298057;6952.652367381712;6801.965990170215;6803.693833777591;6855.828604284733;6857.828554286183;6862.279460656559;6858.862822743417;6993.8251543709775;7023.68393422287;7045.471589630901;7054.682539285847;6677.966610166918;6846.897296540456;6873.381395674413;7010.789676309719;7012.719491220294 19:04:00 INFO - PROCESS | 27178 | |5;yui.html;833.2251006563893;878.1306506558509;939.8167357365314;941.7739742461811;944.1691311645753;15467.458638947624;15552.922235388836;15633.140177290245;15650.060996340228;15669.216539173038;13814;13816.861831381682;13849.09980851244;13872.583822485316;13886.652833679163;882.9735107946756;915.9038300978368;933.6592143867473;937.7561833923195;942.9434233945985;931.4364809290349;938.2775263047449;938.4228699349919;939.642935684439;940.8165407745493;974.3277138774258;980.2501086668705;980.4411485453295;981.018981018981;984.1388784813288;963.2005435488528;971.708487453761;973.3770386952356;973.595957677563;974.1573538888811;712.4870093532649;713.1905287498727;715.1954051691847;716.8602122586097;719.4639993205043;14450.060746051473;14462.783058254134;14487;14525.92737036308;14545.054571452822;14698.338574764055;14771.33528991198;14805.11169329833;14821.555353339418;14831.851681483155;11753.294802311888;11851.46668399924;11931.761364772743;11993;12116.333601651906;4078.653314468274;4110.856120035784;4119.423280740699;4150.439690641755;4180.163967206571;53212.733936330456;54468.45531544713;54685.179722304194;55501.16748248739;55746.885062298934;10743.247972641997;11054;11315.717107072389;11376.146788990858;11614.187006909604;20420.591588168154;20421.183152673726;20475.180992760124;20782.376528704164;21229.575408491743;8700.564971751388;8732.257758090633;8750.212480876624;8868.822623547621;8986.19124278818;4905.166121759309;4919.458859525449;4993.251012348104;5017.648764586517;5096.541311281928;3593.137646964762;3663.2307215484516;3669.449582562637;3676.7977761223387;3681.9079523012138;673.5958424944994;690.5511417578614;692.8441100752291;698.8427603789208;704.7216349541902;701.0220742064791;723.3670538279006;752.6613024139159;772.7025095338336;774.2915232562143;9038.909610903938;10095.828186635807;10203.693889183336;10321.994740702634;10426.322289051339;661.8781165923713;719.586237913202;774.5817258680249;821.137805304428;826.3348004856028;4548.272276435754;4651.209294419957;4682.765861706901;4731.645126615449;4749.26386410107;66498.66750666313;67771.66114169496;68414;68521.3147868525;68640;55232.17151742727;58462.70768646215;59788.40211597915;59995.40004599986;60477.09284360738;54222.728886356104;55527;55801;55811.72094139585;56070.87858242812;9881;9936.701898943043;9975.551100200364;10083.899161008589;10166.135878450414;39596.802015989735;39866.402003969386;41027.1794564113;41193;41494.17011659689;48887.26669099895;49823.252651209536;50393.74803126108;50986.745066275915;51597;12530.812037819258;12773.169743966613;12961.611151665466;13099.95200383986;13179.868201318248;14212.21832799206;14257.144571325754;14275.500357487437;14598.635034124232;15069.773953390928;13385.598432047054;13644.317784110557;13700.109492882932;14335.92832035833;14344.067635603653;13730.176189428666;13785;13814.86185138176;14533.20067396261;14535.927320363331;12678.302693351585;12797.808032879328;13126.737465250833;13584.913206943618;14342.928285358506;11060.446977651247;11153.219274650697;11184.832227516756;11186.10511159089;11281.7743645125;11099.278546894426;11105.278156919774;11377.374244416636;11465.770684586094;11472.196946214019 19:04:00 INFO - PROCESS | 27178 | __end_tp_report 19:04:00 INFO - PROCESS | 27178 | __start_cc_report 19:04:00 INFO - PROCESS | 27178 | _x_x_mozilla_cycle_collect,327 19:04:00 INFO - PROCESS | 27178 | __end_cc_report 19:04:00 INFO - PROCESS | 27178 | __startTimestamp1462586640527__endTimestamp 19:04:00 INFO - PROCESS | 27178 | 19:04:00 INFO - PROCESS | 27178 | ------- Summary: start ------- 19:04:00 INFO - PROCESS | 27178 | Number of tests: 6 19:04:00 INFO - PROCESS | 27178 | 19:04:00 INFO - PROCESS | 27178 | [#0] dojo.html Cycles:165 Average:5686.45 Median:5884.82 stddev:625.44 (10.6%) stddev-sans-first:600.15 19:04:00 INFO - PROCESS | 27178 | Values: 3360.5 3418.0 3425.2 3466.3 3476.5 5662.3 5695.8 5713.9 5735.1 5774.0 5756.5 5762.2 5777.3 5792.4 5795.9 5214.2 5229.9 5263.1 5296.1 5300.3 5073.3 5206.8 5379.4 5385.9 5402.9 5257.0 5284.4 5289.5 5293.6 5316.1 5300.4 5313.7 5323.2 5332.8 5349.2 4988.6 5119.2 5218.0 5236.9 5290.8 5571.6 5593.7 5601.9 5604.4 5663.2 6033.6 6084.1 6090.0 6096.8 6097.2 5919.2 6046.0 6123.1 6154.2 6166.4 5742.1 5746.5 5752.8 5761.9 5782.5 6152.9 6185.6 6198.8 6205.6 6215.0 5957.6 5996.6 6092.6 6121.5 6136.0 6121.1 6137.0 6141.7 6142.3 6147.8 5869.1 6068.2 6086.4 6101.4 6159.8 6059.5 6075.3 6111.3 6122.4 6141.7 4604.0 4623.9 4651.2 4671.3 4704.5 4069.5 4128.3 4147.2 4168.9 4191.3 5677.9 5760.9 5817.4 5870.6 5892.2 6030.0 6050.4 6053.6 6060.5 6063.6 5779.7 5884.8 5923.0 5944.1 5963.3 5177.1 5195.6 5222.1 5222.2 5237.4 5986.1 6274.2 6382.0 6416.8 6434.9 6002.2 6071.3 6076.8 6104.8 6125.0 6137.0 6324.4 6334.6 6341.9 6350.5 5985.7 6074.3 6091.2 6099.3 6122.3 6139.0 6145.9 6152.7 6162.3 6172.3 5865.7 5942.6 5988.3 6016.9 6017.2 5966.6 6023.4 6041.6 6054.4 6087.3 5781.0 5808.3 5860.8 5866.8 5876.7 5866.9 5951.1 5983.9 5992.6 6025.2 5823.6 5852.7 5857.8 5861.9 5901.4 19:04:00 INFO - PROCESS | 27178 | 19:04:00 INFO - PROCESS | 27178 | [#1] ext.html Cycles:180 Average:60826.80 Median:22281.26 stddev:128905.46 (578.5%) stddev-sans-first:129187.88 19:04:00 INFO - PROCESS | 27178 | Values: 645.2 674.7 690.8 713.9 742.0 37186.4 38161.4 38182.6 38550.2 38570.4 42719.4 43590.0 43715.8 43727.0 44005.8 8836.5 8960.0 9046.1 9083.3 9091.7 8912.5 9012.9 9026.4 9028.1 9036.4 9003.5 9046.6 9052.5 9056.0 9065.0 8992.7 9019.6 9037.5 9051.0 9068.9 8882.5 8939.4 8941.9 8977.7 9007.1 39470.2 39744.4 39766.8 39775.2 39803.0 3746.2 3899.9 3920.3 3942.3 4015.5 32354.4 32429.7 32549.8 32702.2 32754.2 4548.4 4557.5 4660.0 4663.3 4673.7 229481.0 230238.0 230313.0 230370.0 232348.8 58540.7 58678.1 58930.7 58946.7 59035.0 68244.7 69717.0 69920.3 70193.0 70334.3 18399.9 18494.8 18565.6 18639.5 18702.5 13851.0 13985.2 14000.4 14014.8 14099.9 20221.0 20489.8 20589.5 20665.1 20718.4 7349.0 7760.7 7795.8 7909.9 7971.0 1122.0 1153.2 1170.2 1188.5 1217.5 32119.6 32914.5 33142.0 33311.8 33793.2 1168.8 1218.7 1229.2 1258.6 1267.4 16553.3 16565.0 16625.5 16762.2 16966.4 499370.0 571737.0 574320.0 577578.0 947355.0 59171.0 59490.7 60112.0 60118.0 60579.2 1533.5 1545.0 1565.0 1569.2 1641.0 32592.2 33025.0 33043.8 33131.0 33717.2 53028.0 53801.7 53827.7 53968.5 54136.5 456673.0 458768.0 461107.0 463188.0 464197.0 30147.7 30330.4 30554.0 30679.5 30728.4 48652.8 48966.3 49230.5 49233.8 49430.5 38437.2 38931.8 39125.0 39193.0 39560.6 40124.6 40547.0 40884.8 41583.0 41935.2 41537.0 41916.0 41970.0 42236.0 42283.0 35648.8 35748.8 35899.6 36252.5 36370.6 28586.0 28635.9 28699.4 28748.0 28835.6 19:04:00 INFO - PROCESS | 27178 | 19:04:00 INFO - PROCESS | 27178 | [#2] jquery.html Cycles:180 Average:31070.17 Median:13249.11 stddev:91997.12 (694.4%) stddev-sans-first:92226.42 19:04:00 INFO - PROCESS | 27178 | Values: 426.2 427.9 430.1 436.9 441.6 18719.3 19022.5 19445.6 20372.0 20893.3 19704.3 20097.3 20140.2 20300.4 20315.2 5537.5 5672.9 5813.9 5814.3 5817.3 4007.0 5698.5 5712.5 5748.9 5980.5 5949.1 5960.4 5977.0 5978.5 5994.4 5897.4 5944.7 6611.8 6620.0 6675.6 5876.4 5886.1 5902.8 5918.0 5925.3 14422.1 18675.3 21577.2 23910.2 24035.2 2463.1 2553.6 2587.2 2605.5 2749.9 10047.8 10138.4 10670.5 10680.3 10731.9 2009.2 2093.1 2104.2 2133.1 2145.2 73143.0 79251.6 79313.0 79991.0 80100.0 11401.7 11411.9 11517.8 11655.4 11710.2 16204.3 16231.8 16330.5 16345.3 16359.6 8827.9 8867.5 8878.5 8997.6 9198.0 8803.3 8815.2 8896.6 8991.9 9069.3 4931.6 5008.4 5052.0 5059.9 5112.5 2000.9 2046.5 2098.6 2140.3 2145.4 941.1 978.8 984.9 994.9 1070.9 16645.8 17707.7 18643.3 19049.9 19581.0 1032.2 1065.3 1079.4 1123.2 1144.3 10092.3 10790.9 10827.4 10855.7 11069.4 543394.0 548060.0 552206.0 571815.0 584322.0 91502.0 92495.5 93356.5 94925.5 97576.0 1063.1 1092.0 1098.9 1099.9 1102.9 16828.5 16944.2 17131.7 17206.2 17321.0 40147.6 40628.2 41226.6 41603.4 41679.0 54133.7 59568.0 60704.0 60942.4 61331.7 8761.6 8783.5 8953.7 9258.9 9357.5 10226.2 13807.7 13992.2 14054.5 14059.0 11558.6 11621.5 11772.9 11783.2 12022.3 11392.3 11789.9 11795.6 11897.3 12200.9 11912.8 11935.3 11957.7 11985.9 12046.3 8933.9 9239.8 9261.4 9330.8 9334.4 11325.0 11344.5 11414.6 11481.6 11517.9 19:04:00 INFO - PROCESS | 27178 | 19:04:00 INFO - PROCESS | 27178 | [#3] mootools.html Cycles:180 Average:5955.86 Median:4718.29 stddev:3233.24 (68.5%) stddev-sans-first:3225.36 19:04:00 INFO - PROCESS | 27178 | Values: 1550.2 1601.6 1772.0 1895.4 1908.4 7700.3 8374.9 8572.9 8803.6 8808.6 8309.0 8332.8 8344.3 8363.6 8409.1 2427.9 2432.2 2445.7 2447.1 2460.2 2448.9 2465.4 2487.3 2489.6 2491.7 2429.3 2474.3 2478.2 2483.5 2487.2 2412.8 2416.3 2427.6 2457.7 2471.0 2448.3 2449.4 2488.2 2489.8 2522.3 8858.2 8921.6 8926.7 8927.4 8933.2 5467.3 5592.7 5621.3 5621.5 5633.7 3517.3 3565.1 3640.9 3643.8 3649.5 1114.5 1118.3 1149.2 1151.8 1152.3 12487.7 12508.1 12552.7 12562.7 12589.1 4956.2 4988.9 4992.6 5103.8 5165.8 10717.6 10729.9 10744.5 10772.7 10800.7 5639.4 5664.7 5676.3 5679.1 5693.3 4447.0 5036.7 5042.4 5109.0 5177.6 4359.9 4365.0 4371.7 4384.5 4480.4 1399.7 1422.6 1422.8 1439.8 1441.4 910.5 1039.4 1072.6 1093.0 1097.4 6163.8 6446.0 6454.2 6495.7 6505.0 1003.3 1062.1 1098.8 1141.7 1142.1 4155.6 4222.9 4259.8 4281.6 4291.2 10308.9 10552.1 10628.1 10674.4 10721.4 10295.4 10454.3 10470.0 10519.6 10533.3 8088.1 8137.8 8345.5 8436.6 8476.2 6290.4 6304.0 6340.4 6357.7 6507.4 9800.1 9858.7 9900.5 10028.6 10097.7 9963.9 10066.6 10275.0 10445.4 10451.8 8007.8 8141.1 8156.1 8192.8 8201.2 8627.9 8674.9 8695.6 8711.4 8729.6 7758.2 7987.2 8041.5 8099.6 8108.1 7604.7 7637.7 7724.7 7920.6 7927.4 6770.2 7307.4 7345.0 7371.7 7373.6 5497.9 5502.7 5535.9 5588.0 5652.6 5417.1 5423.4 5444.6 5590.5 5607.9 19:04:00 INFO - PROCESS | 27178 | 19:04:00 INFO - PROCESS | 27178 | [#4] prototype.html Cycles:180 Average:5878.74 Median:6778.47 stddev:1772.21 (26.1%) stddev-sans-first:1728.14 19:04:00 INFO - PROCESS | 27178 | Values: 362.7 364.8 371.4 375.5 376.6 6529.5 6592.2 6697.3 6707.8 6745.8 6677.3 6710.2 6761.7 6769.3 6769.9 5065.3 5075.5 5088.5 5091.3 5093.5 5061.6 5086.3 5087.4 5088.1 5096.2 5013.0 5048.7 5052.4 5052.7 5054.4 4797.2 4938.3 4940.4 5031.0 5037.2 4252.8 4259.6 4268.3 4290.0 4291.2 6308.2 6320.3 6346.9 6356.5 6366.2 5618.7 5749.9 5759.2 5795.9 5796.9 6999.5 7000.3 7003.4 7004.8 7006.6 4742.8 4749.2 4752.7 4756.8 4764.4 7283.3 7315.0 7335.1 7359.3 7365.4 4909.0 4942.4 4963.0 4964.7 5092.6 5088.5 5089.7 5130.3 5141.8 5151.4 5846.4 5873.6 5914.3 5934.1 5950.5 7097.5 7186.9 7188.0 7190.6 7194.2 1796.9 1821.5 1824.0 1824.8 1825.1 1184.2 1188.0 1215.6 1231.9 1240.1 6811.1 6828.4 6832.2 6833.8 6837.1 7208.1 7217.1 7228.3 7232.7 7248.9 6787.0 6798.3 6798.7 6815.5 6829.0 3875.1 3896.6 3928.4 3943.9 3965.4 7521.6 7550.1 7563.5 7579.3 7598.3 7318.6 7319.9 7360.4 7365.2 7367.4 7500.6 7512.3 7513.6 7522.9 7569.9 7066.2 7211.4 7224.8 7240.7 7245.7 7104.6 7133.8 7135.1 7142.1 7152.3 7550.8 7557.8 7558.2 7568.1 7569.8 5092.1 5118.7 5125.2 5132.9 5141.1 7074.9 7207.7 7212.4 7224.7 7226.9 6965.8 6996.8 7009.0 7016.6 7022.5 6879.8 6934.9 6934.9 6950.4 6952.7 6802.0 6803.7 6855.8 6857.8 6862.3 6858.9 6993.8 7023.7 7045.5 7054.7 6678.0 6846.9 6873.4 7010.8 7012.7 19:04:00 INFO - PROCESS | 27178 | 19:04:00 INFO - PROCESS | 27178 | [#5] yui.html Cycles:180 Average:15986.87 Median:4364.22 stddev:18505.49 (424.0%) stddev-sans-first:18522.41 19:04:00 INFO - PROCESS | 27178 | Values: 833.2 878.1 939.8 941.8 944.2 15467.5 15552.9 15633.1 15650.1 15669.2 13814.0 13816.9 13849.1 13872.6 13886.7 883.0 915.9 933.7 937.8 942.9 931.4 938.3 938.4 939.6 940.8 974.3 980.3 980.4 981.0 984.1 963.2 971.7 973.4 973.6 974.2 712.5 713.2 715.2 716.9 719.5 14450.1 14462.8 14487.0 14525.9 14545.1 14698.3 14771.3 14805.1 14821.6 14831.9 11753.3 11851.5 11931.8 11993.0 12116.3 4078.7 4110.9 4119.4 4150.4 4180.2 53212.7 54468.5 54685.2 55501.2 55746.9 10743.2 11054.0 11315.7 11376.1 11614.2 20420.6 20421.2 20475.2 20782.4 21229.6 8700.6 8732.3 8750.2 8868.8 8986.2 4905.2 4919.5 4993.3 5017.6 5096.5 3593.1 3663.2 3669.4 3676.8 3681.9 673.6 690.6 692.8 698.8 704.7 701.0 723.4 752.7 772.7 774.3 9038.9 10095.8 10203.7 10322.0 10426.3 661.9 719.6 774.6 821.1 826.3 4548.3 4651.2 4682.8 4731.6 4749.3 66498.7 67771.7 68414.0 68521.3 68640.0 55232.2 58462.7 59788.4 59995.4 60477.1 54222.7 55527.0 55801.0 55811.7 56070.9 9881.0 9936.7 9975.6 10083.9 10166.1 39596.8 39866.4 41027.2 41193.0 41494.2 48887.3 49823.3 50393.7 50986.7 51597.0 12530.8 12773.2 12961.6 13100.0 13179.9 14212.2 14257.1 14275.5 14598.6 15069.8 13385.6 13644.3 13700.1 14335.9 14344.1 13730.2 13785.0 13814.9 14533.2 14535.9 12678.3 12797.8 13126.7 13584.9 14342.9 11060.4 11153.2 11184.8 11186.1 11281.8 11099.3 11105.3 11377.4 11465.8 11472.2 19:04:00 INFO - PROCESS | 27178 | -------- Summary: end -------- 19:04:00 INFO - PROCESS | 27178 | 19:04:01 INFO - TEST-INFO | 27178: exit 0 19:04:01 INFO - TEST-OK | dromaeo_css | took 1109078ms 19:04:01 INFO - TEST-START | kraken 19:04:01 INFO - operating with platform_type : linux_ 19:04:01 INFO - Initialising browser for kraken test... 19:04:01 INFO - TEST-INFO | started process 27420 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4sSgeX/profile http://localhost:55343/getInfo.html) 19:04:04 INFO - PROCESS | 27420 | 19:04:04 INFO - PROCESS | 27420 | (process:27496): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:04:05 INFO - PROCESS | 27420 | __metrics Screen width/height:1600/1200 19:04:05 INFO - PROCESS | 27420 | colorDepth:24 19:04:05 INFO - PROCESS | 27420 | Browser inner width/height: 1024/697 19:04:05 INFO - PROCESS | 27420 | __metrics 19:04:05 ERROR - PROCESS | 27420 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 19:04:06 INFO - TEST-INFO | 27420: exit 0 19:04:06 INFO - Browser initialized. 19:04:06 INFO - Running cycle 1/1 for kraken test... 19:04:06 INFO - TEST-INFO | started process 27547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4sSgeX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:04:08 INFO - PROCESS | 27547 | 19:04:08 INFO - PROCESS | 27547 | (process:27617): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:04:18 INFO - PROCESS | 27547 | RSS: Main: 152195072 19:04:18 INFO - PROCESS | 27547 | 19:04:20 INFO - PROCESS | 27547 | Cycle 1(1): loaded http://localhost:55343/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55343/tests/kraken/driver.html?testName=audio-beat-detection) 19:04:21 INFO - PROCESS | 27547 | RSS: Main: 157224960 19:04:21 INFO - PROCESS | 27547 | 19:04:24 INFO - PROCESS | 27547 | Cycle 1(1): loaded http://localhost:55343/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55343/tests/kraken/driver.html?testName=audio-dft) 19:04:24 INFO - PROCESS | 27547 | RSS: Main: 157003776 19:04:24 INFO - PROCESS | 27547 | 19:04:27 INFO - PROCESS | 27547 | Cycle 1(1): loaded http://localhost:55343/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55343/tests/kraken/driver.html?testName=audio-fft) 19:04:28 INFO - PROCESS | 27547 | RSS: Main: 157310976 19:04:28 INFO - PROCESS | 27547 | 19:04:30 INFO - PROCESS | 27547 | Cycle 1(1): loaded http://localhost:55343/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55343/tests/kraken/driver.html?testName=audio-oscillator) 19:04:30 INFO - PROCESS | 27547 | RSS: Main: 157306880 19:04:30 INFO - PROCESS | 27547 | 19:04:33 INFO - PROCESS | 27547 | Cycle 1(1): loaded http://localhost:55343/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55343/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:04:33 INFO - PROCESS | 27547 | RSS: Main: 157188096 19:04:33 INFO - PROCESS | 27547 | 19:04:36 INFO - PROCESS | 27547 | Cycle 1(1): loaded http://localhost:55343/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55343/tests/kraken/driver.html?testName=imaging-darkroom) 19:04:37 INFO - PROCESS | 27547 | RSS: Main: 158097408 19:04:37 INFO - PROCESS | 27547 | 19:04:40 INFO - PROCESS | 27547 | Cycle 1(1): loaded http://localhost:55343/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55343/tests/kraken/driver.html?testName=imaging-desaturate) 19:04:41 INFO - PROCESS | 27547 | RSS: Main: 157814784 19:04:41 INFO - PROCESS | 27547 | 19:04:44 INFO - PROCESS | 27547 | Cycle 1(1): loaded http://localhost:55343/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55343/tests/kraken/driver.html?testName=json-parse-financial) 19:04:44 INFO - PROCESS | 27547 | RSS: Main: 157618176 19:04:44 INFO - PROCESS | 27547 | 19:04:46 INFO - PROCESS | 27547 | Cycle 1(1): loaded http://localhost:55343/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55343/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:04:46 INFO - PROCESS | 27547 | RSS: Main: 157663232 19:04:46 INFO - PROCESS | 27547 | 19:04:48 INFO - PROCESS | 27547 | Cycle 1(1): loaded http://localhost:55343/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55343/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:04:49 INFO - PROCESS | 27547 | RSS: Main: 157396992 19:04:49 INFO - PROCESS | 27547 | 19:04:51 INFO - PROCESS | 27547 | Cycle 1(1): loaded http://localhost:55343/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55343/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:04:52 INFO - PROCESS | 27547 | RSS: Main: 157507584 19:04:52 INFO - PROCESS | 27547 | 19:04:54 INFO - PROCESS | 27547 | Cycle 1(1): loaded http://localhost:55343/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:04:55 INFO - PROCESS | 27547 | RSS: Main: 157945856 19:04:55 INFO - PROCESS | 27547 | 19:04:57 INFO - PROCESS | 27547 | Cycle 1(1): loaded http://localhost:55343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:04:58 INFO - PROCESS | 27547 | RSS: Main: 157876224 19:04:58 INFO - PROCESS | 27547 | 19:05:00 INFO - PROCESS | 27547 | Cycle 1(1): loaded http://localhost:55343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55343/tests/kraken/driver.html?testName=ai-astar) 19:05:00 INFO - PROCESS | 27547 | RSS: Main: 159645696 19:05:00 INFO - PROCESS | 27547 | 19:05:00 INFO - PROCESS | 27547 | __start_tp_report 19:05:00 INFO - PROCESS | 27547 | _x_x_mozilla_page_load 19:05:00 INFO - PROCESS | 27547 | _x_x_mozilla_page_load_details 19:05:00 INFO - PROCESS | 27547 | |i|pagename|runs| 19:05:00 INFO - PROCESS | 27547 | |0;ai-astar;108;110;103;112;110;112;101;110;110;111 19:05:00 INFO - PROCESS | 27547 | |1;audio-beat-detection;160;128;154;185;128;156;161;129;175;134 19:05:00 INFO - PROCESS | 27547 | |2;audio-dft;162;162;162;162;162;162;162;165;161;163 19:05:00 INFO - PROCESS | 27547 | |3;audio-fft;73;76;74;179;77;76;74;76;174;78 19:05:00 INFO - PROCESS | 27547 | |4;audio-oscillator;93;92;157;92;92;92;148;93;91;140 19:05:00 INFO - PROCESS | 27547 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;117;117;118 19:05:00 INFO - PROCESS | 27547 | |6;imaging-darkroom;146;146;146;146;146;147;146;147;147;147 19:05:00 INFO - PROCESS | 27547 | |7;imaging-desaturate;95;95;94;96;95;95;94;95;95;94 19:05:00 INFO - PROCESS | 27547 | |8;json-parse-financial;54;60;56;57;57;61;56;80;54;55 19:05:00 INFO - PROCESS | 27547 | |9;json-stringify-tinderbox;58;58;58;59;59;58;58;58;58;62 19:05:00 INFO - PROCESS | 27547 | |10;stanford-crypto-aes;72;83;80;73;74;74;74;73;73;72 19:05:00 INFO - PROCESS | 27547 | |11;stanford-crypto-ccm;114;114;113;113;114;121;123;124;134;137 19:05:00 INFO - PROCESS | 27547 | |12;stanford-crypto-pbkdf2;158;169;156;166;157;158;164;159;155;159 19:05:00 INFO - PROCESS | 27547 | |13;stanford-crypto-sha256-iterative;68;67;67;67;75;66;65;65;67;72 19:05:00 INFO - PROCESS | 27547 | __end_tp_report 19:05:00 INFO - PROCESS | 27547 | __start_cc_report 19:05:00 INFO - PROCESS | 27547 | _x_x_mozilla_cycle_collect,858 19:05:00 INFO - PROCESS | 27547 | __end_cc_report 19:05:00 INFO - PROCESS | 27547 | __startTimestamp1462586700385__endTimestamp 19:05:00 INFO - PROCESS | 27547 | 19:05:00 INFO - PROCESS | 27547 | ------- Summary: start ------- 19:05:00 INFO - PROCESS | 27547 | Number of tests: 14 19:05:00 INFO - PROCESS | 27547 | 19:05:00 INFO - PROCESS | 27547 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:3.74 (3.4%) stddev-sans-first:3.96 19:05:00 INFO - PROCESS | 27547 | Values: 108.0 110.0 103.0 112.0 110.0 112.0 101.0 110.0 110.0 111.0 19:05:00 INFO - PROCESS | 27547 | 19:05:00 INFO - PROCESS | 27547 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:158.00 stddev:20.49 (13.0%) stddev-sans-first:21.47 19:05:00 INFO - PROCESS | 27547 | Values: 160.0 128.0 154.0 185.0 128.0 156.0 161.0 129.0 175.0 134.0 19:05:00 INFO - PROCESS | 27547 | 19:05:00 INFO - PROCESS | 27547 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 19:05:00 INFO - PROCESS | 27547 | Values: 162.0 162.0 162.0 162.0 162.0 162.0 162.0 165.0 161.0 163.0 19:05:00 INFO - PROCESS | 27547 | 19:05:00 INFO - PROCESS | 27547 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:42.63 (56.1%) stddev-sans-first:44.42 19:05:00 INFO - PROCESS | 27547 | Values: 73.0 76.0 74.0 179.0 77.0 76.0 74.0 76.0 174.0 78.0 19:05:00 INFO - PROCESS | 27547 | 19:05:00 INFO - PROCESS | 27547 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:92.00 stddev:27.44 (29.8%) stddev-sans-first:28.49 19:05:00 INFO - PROCESS | 27547 | Values: 93.0 92.0 157.0 92.0 92.0 92.0 148.0 93.0 91.0 140.0 19:05:00 INFO - PROCESS | 27547 | 19:05:00 INFO - PROCESS | 27547 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:05:00 INFO - PROCESS | 27547 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 19:05:00 INFO - PROCESS | 27547 | 19:05:00 INFO - PROCESS | 27547 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:05:00 INFO - PROCESS | 27547 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 147.0 19:05:00 INFO - PROCESS | 27547 | 19:05:00 INFO - PROCESS | 27547 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 19:05:00 INFO - PROCESS | 27547 | Values: 95.0 95.0 94.0 96.0 95.0 95.0 94.0 95.0 95.0 94.0 19:05:00 INFO - PROCESS | 27547 | 19:05:00 INFO - PROCESS | 27547 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:57.00 stddev:7.73 (13.6%) stddev-sans-first:7.99 19:05:00 INFO - PROCESS | 27547 | Values: 54.0 60.0 56.0 57.0 57.0 61.0 56.0 80.0 54.0 55.0 19:05:00 INFO - PROCESS | 27547 | 19:05:00 INFO - PROCESS | 27547 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:58.00 stddev:1.26 (2.2%) stddev-sans-first:1.32 19:05:00 INFO - PROCESS | 27547 | Values: 58.0 58.0 58.0 59.0 59.0 58.0 58.0 58.0 58.0 62.0 19:05:00 INFO - PROCESS | 27547 | 19:05:00 INFO - PROCESS | 27547 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:74.00 stddev:3.68 (5.0%) stddev-sans-first:3.76 19:05:00 INFO - PROCESS | 27547 | Values: 72.0 83.0 80.0 73.0 74.0 74.0 74.0 73.0 73.0 72.0 19:05:00 INFO - PROCESS | 27547 | 19:05:00 INFO - PROCESS | 27547 | [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:122.00 stddev:8.90 (7.3%) stddev-sans-first:9.10 19:05:00 INFO - PROCESS | 27547 | Values: 114.0 114.0 113.0 113.0 114.0 121.0 123.0 124.0 134.0 137.0 19:05:00 INFO - PROCESS | 27547 | 19:05:00 INFO - PROCESS | 27547 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:159.00 stddev:4.63 (2.9%) stddev-sans-first:4.85 19:05:00 INFO - PROCESS | 27547 | Values: 158.0 169.0 156.0 166.0 157.0 158.0 164.0 159.0 155.0 159.0 19:05:00 INFO - PROCESS | 27547 | 19:05:00 INFO - PROCESS | 27547 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.00 stddev:3.18 (4.7%) stddev-sans-first:3.37 19:05:00 INFO - PROCESS | 27547 | Values: 68.0 67.0 67.0 67.0 75.0 66.0 65.0 65.0 67.0 72.0 19:05:00 INFO - PROCESS | 27547 | -------- Summary: end -------- 19:05:00 INFO - PROCESS | 27547 | 19:05:01 INFO - TEST-INFO | 27547: exit 0 19:05:01 INFO - TEST-OK | kraken | took 60130ms 19:05:01 INFO - SUITE-END | took 1169s 19:05:01 INFO - Completed test suite (00:19:29) 19:05:01 INFO - javascript benchmark 19:05:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.529525866379, 3418.042947974567, 3425.212201193724, 3466.3413951349244, 3476.5306683597723, 5662.348829884564, 5695.772169113241, 5713.885722285552, 5735.08238681811, 5773.971130144343, 5756.453136951994, 5762.164486149506, 5777.306723193223, 5792.449717276862, 5795.884082318351, 5214.165733482653, 5229.921551176735, 5263.0526505229045, 5296.073187192245, 5300.337457817773, 5073.264376665381, 5206.843794686166, 5379.38137114233, 5385.892282154355, 5402.945970540303, 5256.973715131419, 5284.4187139414635, 5289.471052894718, 5293.602979776532, 5316.12283973144, 5300.416954135042, 5313.707746073965, 5323.22813192087, 5332.786688532454, 5349.22436246742, 4988.575971042465, 5119.206522988943, 5218.008578370098, 5236.947630523684, 5290.788368465257, 5571.582131340125, 5593.664380137205, 5601.915971260434, 5604.3835178130375, 5663.1505274208785, 6033.637981721067, 6084.148219249309, 6090.025595904678, 6096.847578810521, 6097.17688112108, 5919.2009078774245, 6045.969770151165, 6123.069106197275, 6154.169187159721, 6166.414190651881, 5742.052561327376, 5746.454086861741, 5752.798652047159, 5761.9135712964335, 5782.479576838063, 6152.876942461216, 6185.567010309325, 6198.752049917953, 6205.565610407319, 6215.0, 5957.6127551709, 5996.550258730613, 6092.634441933498, 6121.479674227651, 6135.969320153371, 6121.081837724377, 6137.0, 6141.662208578571, 6142.293636231891, 6147.754089836357, 5869.06095024794, 6068.241469816273, 6086.391360863879, 6101.389861013952, 6159.81520554384, 6059.454649081604, 6075.27096748393, 6111.318268824403, 6122.418370254819, 6141.692915354304, 4603.95396046042, 4623.86128416148, 4651.209294419957, 4671.299305104194, 4704.482506924235, 4069.5116586009867, 4128.298189307825, 4147.232761939051, 4168.874933751992, 4191.287481128215, 5677.943220567741, 5760.942390576124, 5817.418258174149, 5870.5890587659305, 5892.204552385373, 6030.0, 6050.3949605040025, 6053.636781793107, 6060.545459090586, 6063.575549711478, 5779.682117483495, 5884.823455296348, 5923.022701254331, 5944.138099975479, 5963.314218864886, 5177.145770947826, 5195.636305458657, 5222.086134926372, 5222.216667499905, 5237.397699264558, 5986.072158815304, 6274.152989346379, 6382.042693595998, 6416.807495775134, 6434.903476447857, 6002.249718785152, 6071.301800293023, 6076.817695469143, 6104.755809767559, 6125.0, 6137.009281402767, 6324.367563243639, 6334.6199228044625, 6341.873162536631, 6350.460210882126, 5985.730642121028, 6074.271087469532, 6091.177691011657, 6099.268087829489, 6122.326544080237, 6139.0, 6145.877082458415, 6152.692365381802, 6162.291336496181, 6172.321044685171, 5865.73604187804, 5942.64344139353, 5988.311344195299, 6016.939830601638, 6017.15759793638, 5966.582339236385, 6023.397660233942, 6041.6375017499095, 6054.364291749479, 6087.330393656783, 5781.046127388934, 5808.332041815076, 5860.765569377178, 5866.765329386777, 5876.676782776988, 5866.911996320144, 5951.137085122719, 5983.910241346296, 5992.580519363602, 6025.18659980897, 5823.621464604787, 5852.678102704222, 5857.765689372377, 5861.9413805863105, 5901.439363260483], "value": 5645.944933235004, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.183842439314, 674.7098747538558, 690.8376531515096, 713.9107611548557, 742.0390594180537, 37186.44220336694, 38161.42757858634, 38182.61817381826, 38550.228995420075, 38570.421443678366, 42719.35920961188, 43590.0, 43715.78142109293, 43727.0, 44005.7799711001, 8836.513991730451, 8959.955200223989, 9046.095390460967, 9083.318751093695, 9091.727248182566, 8912.465252084863, 9012.909870901305, 9026.368154229207, 9028.097190280952, 9036.367454278203, 9003.5048072356, 9046.638134474646, 9052.456852588833, 9056.049114842945, 9065.0, 8992.730218093468, 9019.639214431414, 9037.502937338444, 9051.049639787794, 9068.863967040466, 8882.467051976837, 8939.374243802871, 8941.865872011926, 8977.685780997634, 9007.099290071006, 39470.21059578821, 39744.40383394252, 39766.80116599399, 39775.204495910206, 39803.0, 3746.1571146492092, 3899.8742941516985, 3920.274749171384, 3942.2903877302074, 4015.5181378234797, 32354.352912941846, 32429.6757032429, 32549.83725081383, 32702.182445438815, 32754.181145471317, 4548.385967894325, 4557.498675145731, 4659.998100408395, 4663.251280769711, 4673.742944138071, 229481.0, 230238.0, 230313.0, 230370.0, 232348.83825580933, 58540.707296463246, 58678.11982820261, 58930.70534647299, 58946.70526647339, 59035.0, 68244.6587767058, 69717.0, 69920.3007969924, 70193.0, 70334.2966570338, 18399.908000459913, 18494.81505184931, 18565.628687426175, 18639.534011649816, 18702.53243668919, 13851.0, 13985.160890346611, 14000.439982400794, 14014.789778153336, 14099.929500352433, 20221.0, 20489.795102049087, 20589.48526286825, 20665.070071846803, 20718.378448646567, 7348.979030766582, 7760.689572417153, 7795.766127016199, 7909.881351779728, 7971.036145058242, 1121.9551217951355, 1153.1524329617723, 1170.239344426113, 1188.4592510407745, 1217.5008246618843, 32119.64693364748, 32914.50628240578, 33142.0, 33311.83344083313, 33793.15517112043, 1168.807146820782, 1218.7440637466232, 1229.170310040719, 1258.584667059868, 1267.3916520070418, 16553.337866485206, 16565.0, 16625.50123496297, 16762.161891905354, 16966.406175783788, 499370.0, 571737.0, 574320.0, 577578.0, 947355.0, 59171.0, 59490.70254648699, 60112.0, 60118.0, 60579.18262452134, 1533.5322726568504, 1545.0497943764728, 1564.9843501565067, 1569.2232344989304, 1640.9989906157234, 32592.185195370304, 33025.0, 33043.83478082594, 33131.0, 33717.157071073416, 53028.0, 53801.73099134479, 53827.73086134701, 53968.46031539791, 54136.45863541472, 456673.0, 458768.0, 461107.0, 463188.0, 464197.0, 30147.698523015366, 30330.39339213159, 30554.0, 30679.539806902467, 30728.385432290783, 48652.75673621751, 48966.26550601672, 49230.507694924025, 49233.75383123061, 49430.50569494259, 38437.23125537529, 38931.805340973115, 39125.0, 39193.0, 39560.60439395569, 40124.598754012084, 40547.0, 40884.79557602193, 41583.0, 41935.16129677328, 41537.0, 41916.0, 41970.0, 42236.0, 42283.0, 35648.821755891055, 35748.821255893556, 35899.641003590674, 36252.456213157355, 36370.63629363672, 28586.0, 28635.85568326891, 28699.42153181595, 28747.972962920023, 28835.5674664876], "value": 20735.30065359628, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.2327809942103, 427.88233235860156, 430.1268425097053, 436.9235383807834, 441.63785695729496, 18719.3448229312, 19022.524436889085, 19445.611087778238, 20372.0, 20893.268735594258, 19704.310349137784, 20097.29659461919, 20140.194392224294, 20300.390988270337, 20315.18739250432, 5537.501624853762, 5672.914906276409, 5813.854653633651, 5814.273215848019, 5817.301923769132, 4006.9799651001704, 5698.544116470694, 5712.485876271135, 5748.856278593027, 5980.521558275327, 5949.137375080611, 5960.374160713128, 5977.043673012319, 5978.491828194608, 5994.430529099728, 5897.380775018625, 5944.732487038072, 6611.768588099393, 6620.040094186316, 6675.632840193787, 5876.4123587641325, 5886.08765641322, 5902.793402230901, 5917.993941030035, 5925.2889653241455, 14422.134671919614, 18675.34636287737, 21577.24479643205, 23910.16314429004, 24035.158769442987, 2463.0517250858547, 2553.59142537195, 2587.2238328501376, 2605.491929073831, 2749.9450010999667, 10047.799044019152, 10138.442385668784, 10670.466476676134, 10680.305780124345, 10731.946340268327, 2009.2264478175862, 2093.0685844799073, 2104.2214380679247, 2133.0614529606923, 2145.238440353683, 73143.0, 79251.60374198091, 79313.0, 79991.0, 80099.99999999942, 11401.714957125972, 11411.942940285411, 11517.827232591519, 11655.417229138679, 11710.180287379802, 16204.270807813677, 16231.837681623269, 16330.510084697478, 16345.264463099189, 16359.59101022484, 8827.867581986275, 8867.467951922905, 8878.511681857432, 8997.64009439615, 9197.954010229905, 8803.339749518811, 8815.162559556831, 8896.59965301563, 8991.920969483574, 9069.31980101495, 4931.5561599455505, 5008.4240312364545, 5051.974740126349, 5059.924101138486, 5112.514311140436, 2000.9399718008483, 2046.5292982613785, 2098.5802839432176, 2140.3150991682824, 2145.4100122466134, 941.1059493481221, 978.8189185000798, 984.8670429491926, 994.9005099489993, 1070.9410982395887, 16645.750313745302, 17707.73438398425, 18643.254269829325, 19049.904750476435, 19581.0, 1032.210359075308, 1065.3394895165047, 1079.4225089577196, 1123.1913022623698, 1144.3019757947645, 10092.34399764013, 10790.89209107899, 10827.404492752818, 10855.67432977012, 11069.446527673585, 543394.0, 548060.0, 552206.0, 571815.0, 584322.0, 91502.0, 92495.53752231196, 93356.53321733484, 94925.5253723727, 97576.0, 1063.1335461598771, 1091.9945400272948, 1098.8681358237063, 1099.8625171853519, 1102.8897110288906, 16828.495145145665, 16944.237509312356, 17131.657366852345, 17206.22571984289, 17321.0, 40147.598524014385, 40628.1874362517, 41226.58773412227, 41603.37594936139, 41679.0, 54133.72933135309, 59568.0, 60704.0, 60942.39057609367, 61331.693341533006, 8761.561921904007, 8783.472991620523, 8953.686620968236, 9258.888933327775, 9357.53212339394, 10226.181905447398, 13807.723845522833, 13992.230427326187, 14054.464294630268, 14059.0, 11558.595449159238, 11621.5351385947, 11772.882271177179, 11783.234089784137, 12022.27866328023, 11392.25950313227, 11789.941050294694, 11795.643500997496, 11897.286162830258, 12200.877991219973, 11912.821307680219, 11935.283882967049, 11957.701057473632, 11985.880141198477, 12046.277223366626, 8933.883264591926, 9239.815203696024, 9261.398009129385, 9330.766730831783, 9334.39326443779, 11325.037371823488, 11344.489497972776, 11414.600488982845, 11481.598144065252, 11517.884821151682], "value": 9539.799137064678, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1550.2248875562218, 1601.6076061364963, 1771.9911400442995, 1895.412422149133, 1908.3702378215191, 7700.3454706349885, 8374.874376884352, 8572.914270857289, 8803.559822008898, 8808.603612837429, 8309.044459887114, 8332.83334333313, 8344.290735287492, 8363.581820908945, 8409.075001749818, 2427.8664673442954, 2432.1852179519883, 2445.7282213249186, 2447.106806015809, 2460.151247819508, 2448.902043918241, 2465.3713303107684, 2487.2662564543502, 2489.626556016594, 2491.6511688363553, 2429.331933718233, 2474.2948259745976, 2478.182199874046, 2483.52812965536, 2487.166799122296, 2412.7587241275996, 2416.2630397728685, 2427.647991041307, 2457.7173625032992, 2471.0486462711806, 2448.3144719478573, 2449.35092200567, 2488.154027630614, 2489.825712200147, 2522.3441905104805, 8858.247049000842, 8921.643134274622, 8926.687565935226, 8927.37508374414, 8933.151350621745, 5467.343918729778, 5592.692401917893, 5621.325440947113, 5621.465960733764, 5633.718314084279, 3517.278957813642, 3565.090901820045, 3640.8907732767793, 3643.763155394891, 3649.543807024122, 1114.509615769059, 1118.2842980492492, 1149.2127892393737, 1151.7523732397574, 1152.3028567716494, 12487.687807804787, 12508.124431289812, 12552.748945021049, 12562.68593285166, 12589.055820813475, 4956.207006878954, 4988.927380613186, 4992.600591952635, 5103.8468845934685, 5165.845024649267, 10717.571297148026, 10729.892701073046, 10744.516496757664, 10772.730681732863, 10800.729981750363, 5639.379668236573, 5664.745086471119, 5676.347220069662, 5679.148127780783, 5693.259876216065, 4446.9777651111535, 5036.722980236049, 5042.420121686053, 5109.0, 5177.58579313654, 4359.869203923888, 4364.978175109104, 4371.672124590668, 4384.539623339567, 4480.372747815309, 1399.6990647010941, 1422.5945605502588, 1422.8292604887479, 1439.8416174220827, 1441.3730027438098, 910.5356268303213, 1039.443897514841, 1072.6138590107555, 1092.9726756830985, 1097.401915955806, 6163.753449862045, 6445.967770161119, 6454.19322584677, 6495.6752162391695, 6505.0, 1003.3177439341318, 1062.1131355318396, 1098.8296813993843, 1141.6689160143465, 1142.0692135909208, 4155.625993660585, 4222.915541689149, 4259.8083086261195, 4281.550437204049, 4291.2061268664775, 10308.896911030944, 10552.103071239031, 10628.09661178793, 10674.359538427563, 10721.35671859691, 10295.3822770634, 10454.32046916948, 10470.0, 10519.579216831395, 10533.262671612914, 8088.11030786613, 8137.837243255101, 8345.457545259538, 8436.620352084294, 8476.194761497647, 6290.433860952537, 6304.0, 6340.397662222082, 6357.713902874474, 6507.381798729113, 9800.068993445611, 9858.704238872846, 9900.455474948947, 10028.598856045677, 10097.697069087939, 9963.900360996297, 10066.597336106473, 10275.0, 10445.373277603368, 10451.790964180522, 8007.838863364663, 8141.14517975604, 8156.062052863759, 8192.75421737349, 8201.22088401601, 8627.91372086271, 8674.869876951978, 8695.565221738761, 8711.39020268575, 8729.607167677343, 7758.224177582197, 7987.16134805837, 8041.477303975223, 8099.554524501209, 8108.108108107986, 7604.733834315773, 7637.694492220249, 7724.652390642322, 7920.643571039202, 7927.445078844426, 6770.187577490536, 7307.41540676734, 7345.0, 7371.741989030358, 7373.594452305175, 5497.862553436036, 5502.669839809624, 5535.948169847716, 5587.972060139836, 5652.63257888236, 5417.106177480671, 5423.430539793423, 5444.564434845282, 5590.468905453975, 5607.943920560905], "value": 4849.778656883468, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.7370156636437, 364.8394706329215, 371.44839912729594, 375.5212104566675, 376.6421899195765, 6529.477641788658, 6592.208934927809, 6697.3302669733, 6707.7987660370145, 6745.763898263562, 6677.298883617211, 6710.16122984627, 6761.729530818774, 6769.323067693228, 6769.898451523231, 5065.316182315396, 5075.5178258065425, 5088.491150884919, 5091.287219789232, 5093.465186155456, 5061.569766569846, 5086.31334769805, 5087.414947281054, 5088.058709138802, 5096.235564665293, 5013.0, 5048.747562621873, 5052.368453943257, 5052.696838189702, 5054.418741844698, 4797.184478638623, 4938.308636790852, 4940.4318503372215, 5030.974845125787, 5037.168867136937, 4252.829886804555, 4259.595338442843, 4268.253055715269, 4290.034742183015, 4291.163223171483, 6308.179936608258, 6320.273168585625, 6346.904796428057, 6356.491480681534, 6366.204224471941, 5618.747156377973, 5749.942500574983, 5759.1937128802, 5795.9420405796245, 5796.942030579682, 6999.5450295731125, 7000.264972177899, 7003.369696727268, 7004.7548335808515, 7006.614636195059, 4742.834000809955, 4749.1926372516755, 4752.667313288071, 4756.833510827139, 4764.4282686077895, 7283.344498995063, 7315.0, 7335.119785625706, 7359.300866417681, 7365.44759143061, 4909.0, 4942.431620363633, 4962.9751851241235, 4964.67729597575, 5092.643514953992, 5088.465711100355, 5089.720065396365, 5130.30740849988, 5141.794328226829, 5151.381834179922, 5846.386129456431, 5873.647581145145, 5914.290285165722, 5934.080217566284, 5950.523958083343, 7097.503174777819, 7186.92813071873, 7188.029616001772, 7190.568565886064, 7194.172670143001, 1796.8562514998769, 1821.5264031351944, 1824.0241470813316, 1824.771903512061, 1825.0600940515644, 1184.1592469346688, 1187.9940600296943, 1215.562397536886, 1231.9260844349367, 1240.1009268280604, 6811.080504131978, 6828.351306625962, 6832.214295355998, 6833.794986150423, 6837.076994605664, 7208.135023797178, 7217.06178196831, 7228.31331023552, 7232.674529646179, 7248.891266631004, 6787.04981302618, 6798.286179951133, 6798.694058767367, 6815.522913396015, 6829.0, 3875.108724993211, 3896.59085795993, 3928.3714605663527, 3943.9014024649614, 3965.365541513344, 7521.623918804038, 7550.131734850453, 7563.508371955805, 7579.279968402993, 7598.278163574451, 7318.597477138702, 7319.926800731924, 7360.447966402541, 7365.1530074042175, 7367.373773229336, 7500.62496875165, 7512.286332798375, 7513.624318784039, 7522.887156692654, 7569.924300756922, 7066.187388450188, 7211.4230861532005, 7224.819379515554, 7240.710371585077, 7245.746398876014, 7104.573725576482, 7133.785986420416, 7135.072440582691, 7142.107236595426, 7152.284771522806, 7550.7734767957045, 7557.848843022999, 7558.206388329366, 7568.129665088585, 7569.810754731176, 5092.0579692756955, 5118.692878427306, 5125.205593133071, 5132.871678208075, 5141.074606570854, 7074.893876591958, 7207.747728829466, 7212.386947109554, 7224.674889629874, 7226.927730722836, 6965.756198533027, 6996.825079373057, 7009.0, 7016.649167541705, 7022.508424410242, 6879.793606191823, 6934.8613027740175, 6934.930650693428, 6950.374466298057, 6952.652367381712, 6801.965990170215, 6803.693833777591, 6855.828604284733, 6857.828554286183, 6862.279460656559, 6858.862822743417, 6993.8251543709775, 7023.68393422287, 7045.471589630901, 7054.682539285847, 6677.966610166918, 6846.897296540456, 6873.381395674413, 7010.789676309719, 7012.719491220294], "value": 5304.019387616936, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.2251006563893, 878.1306506558509, 939.8167357365314, 941.7739742461811, 944.1691311645753, 15467.458638947624, 15552.922235388836, 15633.140177290245, 15650.060996340228, 15669.216539173038, 13814.0, 13816.861831381682, 13849.09980851244, 13872.583822485316, 13886.652833679163, 882.9735107946756, 915.9038300978368, 933.6592143867473, 937.7561833923195, 942.9434233945985, 931.4364809290349, 938.2775263047449, 938.4228699349919, 939.642935684439, 940.8165407745493, 974.3277138774258, 980.2501086668705, 980.4411485453295, 981.018981018981, 984.1388784813288, 963.2005435488528, 971.708487453761, 973.3770386952356, 973.595957677563, 974.1573538888811, 712.4870093532649, 713.1905287498727, 715.1954051691847, 716.8602122586097, 719.4639993205043, 14450.060746051473, 14462.783058254134, 14487.0, 14525.92737036308, 14545.054571452822, 14698.338574764055, 14771.33528991198, 14805.11169329833, 14821.555353339418, 14831.851681483155, 11753.294802311888, 11851.46668399924, 11931.761364772743, 11993.0, 12116.333601651906, 4078.653314468274, 4110.856120035784, 4119.423280740699, 4150.439690641755, 4180.163967206571, 53212.733936330456, 54468.45531544713, 54685.179722304194, 55501.16748248739, 55746.885062298934, 10743.247972641997, 11054.0, 11315.717107072389, 11376.146788990858, 11614.187006909604, 20420.591588168154, 20421.183152673726, 20475.180992760124, 20782.376528704164, 21229.575408491743, 8700.564971751388, 8732.257758090633, 8750.212480876624, 8868.822623547621, 8986.19124278818, 4905.166121759309, 4919.458859525449, 4993.251012348104, 5017.648764586517, 5096.541311281928, 3593.137646964762, 3663.2307215484516, 3669.449582562637, 3676.7977761223387, 3681.9079523012138, 673.5958424944994, 690.5511417578614, 692.8441100752291, 698.8427603789208, 704.7216349541902, 701.0220742064791, 723.3670538279006, 752.6613024139159, 772.7025095338336, 774.2915232562143, 9038.909610903938, 10095.828186635807, 10203.693889183336, 10321.994740702634, 10426.322289051339, 661.8781165923713, 719.586237913202, 774.5817258680249, 821.137805304428, 826.3348004856028, 4548.272276435754, 4651.209294419957, 4682.765861706901, 4731.645126615449, 4749.26386410107, 66498.66750666313, 67771.66114169496, 68414.0, 68521.3147868525, 68640.0, 55232.17151742727, 58462.70768646215, 59788.40211597915, 59995.40004599986, 60477.09284360738, 54222.728886356104, 55527.0, 55801.0, 55811.72094139585, 56070.87858242812, 9881.0, 9936.701898943043, 9975.551100200364, 10083.899161008589, 10166.135878450414, 39596.802015989735, 39866.402003969386, 41027.1794564113, 41193.0, 41494.17011659689, 48887.26669099895, 49823.252651209536, 50393.74803126108, 50986.745066275915, 51597.0, 12530.812037819258, 12773.169743966613, 12961.611151665466, 13099.95200383986, 13179.868201318248, 14212.21832799206, 14257.144571325754, 14275.500357487437, 14598.635034124232, 15069.773953390928, 13385.598432047054, 13644.317784110557, 13700.109492882932, 14335.92832035833, 14344.067635603653, 13730.176189428666, 13785.0, 13814.86185138176, 14533.20067396261, 14535.927320363331, 12678.302693351585, 12797.808032879328, 13126.737465250833, 13584.913206943618, 14342.928285358506, 11060.446977651247, 11153.219274650697, 11184.832227516756, 11186.10511159089, 11281.7743645125, 11099.278546894426, 11105.278156919774, 11377.374244416636, 11465.770684586094, 11472.196946214019], "value": 7313.054420134888, "unit": "score"}], "name": "dromaeo_css", "value": 7710.360997522912, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 103.0, 112.0, 110.0, 112.0, 101.0, 110.0, 110.0, 111.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 128.0, 154.0, 185.0, 128.0, 156.0, 161.0, 129.0, 175.0, 134.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 165.0, 161.0, 163.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 74.0, 179.0, 77.0, 76.0, 74.0, 76.0, 174.0, 78.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 157.0, 92.0, 92.0, 92.0, 148.0, 93.0, 91.0, 140.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 60.0, 56.0, 57.0, 57.0, 61.0, 56.0, 80.0, 54.0, 55.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 59.0, 59.0, 58.0, 58.0, 58.0, 58.0, 62.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 83.0, 80.0, 73.0, 74.0, 74.0, 74.0, 73.0, 73.0, 72.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 114.0, 121.0, 123.0, 124.0, 134.0, 137.0], "value": 120.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 169.0, 156.0, 166.0, 157.0, 158.0, 164.0, 159.0, 155.0, 159.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 75.0, 66.0, 65.0, 65.0, 67.0, 72.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1526.2999999999997, "alertThreshold": 2.0}]} 19:05:01 INFO - Return code: 0 19:05:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:05:01 ERROR - # TBPL SUCCESS # 19:05:01 INFO - Running post-action listener: _resource_record_post_action 19:05:01 INFO - Running post-run listener: _resource_record_post_run 19:05:02 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 262144; Write bytes: 501530624; Read time: 16; Write time: 413100 19:05:02 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248377344; Read time: 0; Write time: 235052 19:05:02 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 262144; Write bytes: 253153280; Read time: 16; Write time: 178048 19:05:02 INFO - Running post-run listener: _upload_blobber_files 19:05:02 INFO - Blob upload gear active. 19:05:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:05:02 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 19:05:02 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'] 19:05:02 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 19:05:03 INFO - (blobuploader) - INFO - Open directory for files ... 19:05:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:05:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:05:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:05:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:05:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:05:04 INFO - (blobuploader) - INFO - Done attempting. 19:05:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:05:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:05:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:05:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:05:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:05:04 INFO - (blobuploader) - INFO - Done attempting. 19:05:04 INFO - (blobuploader) - INFO - Iteration through files over. 19:05:04 INFO - Return code: 0 19:05:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:05:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:05:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3d78a3dc7529f26543686546c493b10043a8abfe885c7e2cdff9b28ce5f69161285f221ab654c4824fe9ae4a3a6fa2b636d5e492e5ba35746a5dbc8bc5b34796", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84a9ae69e08a5ed39316bd4346243047e7067eb79546a6cfdedabdf228a71eed95a5f0457fd5b80974e3832b89e3bf17b6dda994ef2d35b236f59358f4cf3ef8"} 19:05:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:05:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:05:04 INFO - Contents: 19:05:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3d78a3dc7529f26543686546c493b10043a8abfe885c7e2cdff9b28ce5f69161285f221ab654c4824fe9ae4a3a6fa2b636d5e492e5ba35746a5dbc8bc5b34796", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84a9ae69e08a5ed39316bd4346243047e7067eb79546a6cfdedabdf228a71eed95a5f0457fd5b80974e3832b89e3bf17b6dda994ef2d35b236f59358f4cf3ef8"} 19:05:04 INFO - Running post-run listener: copy_logs_to_upload_dir 19:05:04 INFO - Copying logs to upload dir... 19:05:04 INFO - mkdir: /builds/slave/test/build/upload/logs 19:05:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.498022 ========= master_lag: 84.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2016-05-06 19:06:29.028741) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 19:06:29.031927) ========= 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=0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005 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/3d78a3dc7529f26543686546c493b10043a8abfe885c7e2cdff9b28ce5f69161285f221ab654c4824fe9ae4a3a6fa2b636d5e492e5ba35746a5dbc8bc5b34796", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84a9ae69e08a5ed39316bd4346243047e7067eb79546a6cfdedabdf228a71eed95a5f0457fd5b80974e3832b89e3bf17b6dda994ef2d35b236f59358f4cf3ef8"} build_url:https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/OnkDVrxkSwair7j5eUc8TQ/artifacts/public/build/firefox-48.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/3d78a3dc7529f26543686546c493b10043a8abfe885c7e2cdff9b28ce5f69161285f221ab654c4824fe9ae4a3a6fa2b636d5e492e5ba35746a5dbc8bc5b34796", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84a9ae69e08a5ed39316bd4346243047e7067eb79546a6cfdedabdf228a71eed95a5f0457fd5b80974e3832b89e3bf17b6dda994ef2d35b236f59358f4cf3ef8"}' ========= master_lag: 0.31 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 19:06:29.348372) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-05-06 19:06:29.348695) ========= 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=0274524eba3bdaad075c2247000001d4-1462582267.273920-2073671005 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 3.77 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-05-06 19:06:33.123457) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 19:06:33.123760) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 19:06:33.199650) ========= ========= Total master_lag: 88.87 =========