builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1462964743.69 results: success (0) buildid: 20160510142413 builduid: 93e058acf8334e7aae447a8479c457fb revision: 1dd42a351054c5b697873d647169019d4d77d762 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:43.691696) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:43.692554) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:43.693035) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:43.711139) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:43.711644) ========= 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=eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 04:05:43-- 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% 29.4M=0s 2016-05-11 04:05:44 (29.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089191 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:43.816797) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:43.817322) ========= 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=eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014472 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:43.868552) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:43.869076) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1dd42a351054c5b697873d647169019d4d77d762 --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 1dd42a351054c5b697873d647169019d4d77d762 --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=eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 04:05:44,142 truncating revision to first 12 chars 2016-05-11 04:05:44,142 Setting DEBUG logging. 2016-05-11 04:05:44,142 attempt 1/10 2016-05-11 04:05:44,142 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1dd42a351054?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 04:05:44,557 unpacking tar archive at: mozilla-aurora-1dd42a351054/testing/mozharness/ program finished with exit code 0 elapsedTime=0.677933 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.561167) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.561470) ========= script_repo_revision: 1dd42a351054c5b697873d647169019d4d77d762 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.561893) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.562166) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.570372) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-11 04:05:44.570666) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:44 INFO - MultiFileLogger online at 20160511 04:05:44 in /builds/slave/test 04:05:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:05:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:44 INFO - {'append_to_log': False, 04:05:44 INFO - 'base_work_dir': '/builds/slave/test', 04:05:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:05:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:44 INFO - 'branch': 'Mozilla-Aurora', 04:05:44 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:44 INFO - 'config_files': ('talos/linux_config.py',), 04:05:44 INFO - 'default_actions': ('clobber', 04:05:44 INFO - 'read-buildbot-config', 04:05:44 INFO - 'download-and-extract', 04:05:44 INFO - 'populate-webroot', 04:05:44 INFO - 'create-virtualenv', 04:05:44 INFO - 'install', 04:05:44 INFO - 'run-tests'), 04:05:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:44 INFO - 'download_minidump_stackwalk': True, 04:05:44 INFO - 'download_symbols': 'ondemand', 04:05:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:44 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:44 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:44 INFO - 'installer_path': 'installer.exe', 04:05:44 INFO - 'log_level': 'info', 04:05:44 INFO - 'log_name': 'talos', 04:05:44 INFO - 'log_to_console': True, 04:05:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:44 INFO - 'opt_config_files': (), 04:05:44 INFO - 'pip_index': False, 04:05:44 INFO - 'sps_profile': False, 04:05:44 INFO - 'sps_profile_interval': 0, 04:05:44 INFO - 'suite': 'dromaeojs', 04:05:44 INFO - 'system_bits': '32', 04:05:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:44 INFO - 'title': 'talos-linux64-ix-010', 04:05:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:44 INFO - 'use_talos_json': True, 04:05:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:44 INFO - 'work_dir': 'build'} 04:05:44 INFO - ##### 04:05:44 INFO - ##### Running clobber step. 04:05:44 INFO - ##### 04:05:44 INFO - Running pre-action listener: _resource_record_pre_action 04:05:44 INFO - Running main action method: clobber 04:05:44 INFO - rmtree: /builds/slave/test/build 04:05:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:45 INFO - Running post-action listener: _resource_record_post_action 04:05:45 INFO - ##### 04:05:45 INFO - ##### Running read-buildbot-config step. 04:05:45 INFO - ##### 04:05:45 INFO - Running pre-action listener: _resource_record_pre_action 04:05:45 INFO - Running main action method: read_buildbot_config 04:05:45 INFO - Using buildbot properties: 04:05:45 INFO - { 04:05:45 INFO - "project": "", 04:05:45 INFO - "product": "firefox", 04:05:45 INFO - "script_repo_revision": "production", 04:05:45 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:05:45 INFO - "repository": "", 04:05:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:05:45 INFO - "buildid": "20160510142413", 04:05:45 INFO - "pgo_build": "True", 04:05:45 INFO - "basedir": "/builds/slave/test", 04:05:45 INFO - "buildnumber": 229, 04:05:45 INFO - "slavename": "talos-linux64-ix-010", 04:05:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:05:45 INFO - "platform": "ubuntu64_hw", 04:05:45 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:05:45 INFO - "branch": "mozilla-aurora", 04:05:45 INFO - "repo_path": "releases/mozilla-aurora", 04:05:45 INFO - "revision": "1dd42a351054c5b697873d647169019d4d77d762", 04:05:45 INFO - "stage_platform": "linux64-pgo", 04:05:45 INFO - "builduid": "93e058acf8334e7aae447a8479c457fb", 04:05:45 INFO - "slavebuilddir": "test" 04:05:45 INFO - } 04:05:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 04:05:45 INFO - Running post-action listener: _resource_record_post_action 04:05:45 INFO - ##### 04:05:45 INFO - ##### Running download-and-extract step. 04:05:45 INFO - ##### 04:05:45 INFO - Running pre-action listener: _resource_record_pre_action 04:05:45 INFO - Running main action method: download_and_extract 04:05:45 INFO - mkdir: /builds/slave/test/build/tests 04:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:45 INFO - https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:05:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:05:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:05:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/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 04:05:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/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 04:05:46 INFO - Downloaded 1361 bytes. 04:05:46 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:05:46 INFO - Using the following test package requirements: 04:05:46 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:05:46 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:05:46 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:05:46 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:46 INFO - u'jsshell-linux-x86_64.zip'], 04:05:46 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:05:46 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:05:46 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:05:46 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:05:46 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:05:46 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:05:46 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:46 INFO - https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:05:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:05:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:05:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/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 04:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/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 04:05:47 INFO - Downloaded 23800226 bytes. 04:05:47 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'] 04:05:47 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 04:05:48 INFO - Return code: 0 04:05:48 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 04:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:48 INFO - https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:05:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:05:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:05:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/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 04:05:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/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 04:05:51 INFO - Downloaded 23800226 bytes. 04:05:51 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'] 04:05:51 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 04:05:52 INFO - Return code: 0 04:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:52 INFO - https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:05:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:05:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:05:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/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 04:05:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/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 04:05:54 INFO - Downloaded 10840145 bytes. 04:05:54 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'] 04:05:54 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 04:05:54 INFO - Return code: 0 04:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:54 INFO - https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:05:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:05:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:05:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/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 04:05:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/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 04:05:55 INFO - Downloaded 62686755 bytes. 04:05:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:05:55 INFO - mkdir: /builds/slave/test/properties 04:05:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:05:55 INFO - Writing to file /builds/slave/test/properties/build_url 04:05:55 INFO - Contents: 04:05:55 INFO - build_url:https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:05:56 INFO - Running post-action listener: _resource_record_post_action 04:05:56 INFO - Running post-action listener: set_extra_try_arguments 04:05:56 INFO - ##### 04:05:56 INFO - ##### Running populate-webroot step. 04:05:56 INFO - ##### 04:05:56 INFO - Running pre-action listener: _resource_record_pre_action 04:05:56 INFO - Running main action method: populate_webroot 04:05:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:05:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:05:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:05:56 INFO - '--tppagecycles', 04:05:56 INFO - '7'], 04:05:56 INFO - 'tests': ['tsvgm']}}, 04:05:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:05:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:05:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:05:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:05:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:05:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:05:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:56 INFO - 'talos_options': ['--disable-e10s'], 04:05:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:56 INFO - 'talos_options': ['--disable-e10s'], 04:05:56 INFO - 'tests': ['damp', 'tps']}, 04:05:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:56 INFO - 'tests': ['damp', 'tps']}, 04:05:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:05:56 INFO - 'tests': ['dromaeo_dom']}, 04:05:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:05:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:05:56 INFO - 'tests': ['a11yr', 04:05:56 INFO - 'ts_paint', 04:05:56 INFO - 'tpaint', 04:05:56 INFO - 'sessionrestore', 04:05:56 INFO - 'sessionrestore_no_auto_restore', 04:05:56 INFO - 'tabpaint']}, 04:05:56 INFO - 'other-e10s': {'tests': ['a11yr', 04:05:56 INFO - 'ts_paint', 04:05:56 INFO - 'tpaint', 04:05:56 INFO - 'sessionrestore', 04:05:56 INFO - 'sessionrestore_no_auto_restore', 04:05:56 INFO - 'tabpaint']}, 04:05:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:05:56 INFO - 'ts_paint', 04:05:56 INFO - 'tpaint', 04:05:56 INFO - 'sessionrestore', 04:05:56 INFO - 'sessionrestore_no_auto_restore', 04:05:56 INFO - 'tabpaint']}, 04:05:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:05:56 INFO - 'ts_paint', 04:05:56 INFO - 'tpaint', 04:05:56 INFO - 'sessionrestore', 04:05:56 INFO - 'sessionrestore_no_auto_restore', 04:05:56 INFO - 'tabpaint']}, 04:05:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:05:56 INFO - 'tests': ['a11yr', 04:05:56 INFO - 'ts_paint', 04:05:56 INFO - 'tpaint', 04:05:56 INFO - 'sessionrestore', 04:05:56 INFO - 'sessionrestore_no_auto_restore', 04:05:56 INFO - 'tabpaint']}, 04:05:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:05:56 INFO - 'tests': ['a11yr', 04:05:56 INFO - 'ts_paint', 04:05:56 INFO - 'tpaint', 04:05:56 INFO - 'sessionrestore', 04:05:56 INFO - 'sessionrestore_no_auto_restore', 04:05:56 INFO - 'tabpaint']}, 04:05:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:05:56 INFO - 'tests': ['tsvgx', 04:05:56 INFO - 'tsvgr_opacity', 04:05:56 INFO - 'tart', 04:05:56 INFO - 'tscrollx', 04:05:56 INFO - 'cart']}, 04:05:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:05:56 INFO - 'tsvgr_opacity', 04:05:56 INFO - 'tart', 04:05:56 INFO - 'tscrollx', 04:05:56 INFO - 'cart']}, 04:05:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:56 INFO - 'talos_options': ['--disable-e10s'], 04:05:56 INFO - 'tests': ['tp5o']}, 04:05:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:56 INFO - 'tests': ['tp5o']}, 04:05:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:56 INFO - 'talos_options': ['--disable-e10s', 04:05:56 INFO - '--xperf_path', 04:05:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:56 INFO - 'tests': ['tp5n']}, 04:05:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:56 INFO - 'talos_options': ['--xperf_path', 04:05:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:56 INFO - 'tests': ['tp5n']}}, 04:05:56 INFO - 'talos.zip': {'path': '', 04:05:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:05:56 INFO - Running post-action listener: _resource_record_post_action 04:05:56 INFO - ##### 04:05:56 INFO - ##### Running create-virtualenv step. 04:05:56 INFO - ##### 04:05:56 INFO - Running pre-action listener: _resource_record_pre_action 04:05:56 INFO - Running main action method: create_virtualenv 04:05:56 INFO - Creating virtualenv /builds/slave/test/build/venv 04:05:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:05:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:05:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:05:56 INFO - Using real prefix '/usr' 04:05:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:05:57 INFO - Installing distribute.............................................................................................................................................................................................done. 04:05:59 INFO - Installing pip.................done. 04:05:59 INFO - Return code: 0 04:05:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:59 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 0x7f74cd2f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b65410>, '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 0x1b66310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b667a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:05:59 INFO - Using env: {'DISPLAY': ':0', 04:05:59 INFO - 'HOME': '/home/cltbld', 04:05:59 INFO - 'LANG': 'en_US.UTF-8', 04:05:59 INFO - 'LANGUAGE': 'en_US:en', 04:05:59 INFO - 'LOGNAME': 'cltbld', 04:05:59 INFO - 'MAIL': '/var/mail/cltbld', 04:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:59 INFO - 'MOZ_NO_REMOTE': '1', 04:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:59 INFO - 'NO_EM_RESTART': '1', 04:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:59 INFO - 'PWD': '/builds/slave/test', 04:05:59 INFO - 'SHELL': '/bin/bash', 04:05:59 INFO - 'SHLVL': '1', 04:05:59 INFO - 'TERM': 'linux', 04:05:59 INFO - 'TMOUT': '86400', 04:05:59 INFO - 'USER': 'cltbld', 04:05:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 04:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:59 INFO - '_': '/tools/buildbot/bin/python'} 04:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:05:59 INFO - Cleaning up... 04:05:59 INFO - Return code: 0 04:05:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:59 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 0x7f74cd2f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b65410>, '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 0x1b66310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b667a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:05:59 INFO - Using env: {'DISPLAY': ':0', 04:05:59 INFO - 'HOME': '/home/cltbld', 04:05:59 INFO - 'LANG': 'en_US.UTF-8', 04:05:59 INFO - 'LANGUAGE': 'en_US:en', 04:05:59 INFO - 'LOGNAME': 'cltbld', 04:05:59 INFO - 'MAIL': '/var/mail/cltbld', 04:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:59 INFO - 'MOZ_NO_REMOTE': '1', 04:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:59 INFO - 'NO_EM_RESTART': '1', 04:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:59 INFO - 'PWD': '/builds/slave/test', 04:05:59 INFO - 'SHELL': '/bin/bash', 04:05:59 INFO - 'SHLVL': '1', 04:05:59 INFO - 'TERM': 'linux', 04:05:59 INFO - 'TMOUT': '86400', 04:05:59 INFO - 'USER': 'cltbld', 04:05:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 04:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:59 INFO - '_': '/tools/buildbot/bin/python'} 04:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:59 INFO - Downloading/unpacking psutil>=0.7.1 04:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:06:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:01 INFO - Installing collected packages: psutil 04:06:01 INFO - Running setup.py install for psutil 04:06:01 INFO - building 'psutil._psutil_linux' extension 04:06:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:06:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:06:01 INFO - building 'psutil._psutil_posix' extension 04:06:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:06:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:06:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:02 INFO - Successfully installed psutil 04:06:02 INFO - Cleaning up... 04:06:02 INFO - Return code: 0 04:06:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:06: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')]} 04:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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')]} 04:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:02 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 0x7f74cd2f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b65410>, '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 0x1b66310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b667a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:06:02 INFO - Using env: {'DISPLAY': ':0', 04:06:02 INFO - 'HOME': '/home/cltbld', 04:06:02 INFO - 'LANG': 'en_US.UTF-8', 04:06:02 INFO - 'LANGUAGE': 'en_US:en', 04:06:02 INFO - 'LOGNAME': 'cltbld', 04:06:02 INFO - 'MAIL': '/var/mail/cltbld', 04:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:02 INFO - 'MOZ_NO_REMOTE': '1', 04:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:02 INFO - 'NO_EM_RESTART': '1', 04:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:02 INFO - 'PWD': '/builds/slave/test', 04:06:02 INFO - 'SHELL': '/bin/bash', 04:06:02 INFO - 'SHLVL': '1', 04:06:02 INFO - 'TERM': 'linux', 04:06:02 INFO - 'TMOUT': '86400', 04:06:02 INFO - 'USER': 'cltbld', 04:06:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 04:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:02 INFO - '_': '/tools/buildbot/bin/python'} 04:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:06:04 INFO - Installing collected packages: mozsystemmonitor 04:06:04 INFO - Running setup.py install for mozsystemmonitor 04:06:04 INFO - Successfully installed mozsystemmonitor 04:06:04 INFO - Cleaning up... 04:06:04 INFO - Return code: 0 04:06:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f74cd2f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b65410>, '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 0x1b66310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b667a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:06:04 INFO - Using env: {'DISPLAY': ':0', 04:06:04 INFO - 'HOME': '/home/cltbld', 04:06:04 INFO - 'LANG': 'en_US.UTF-8', 04:06:04 INFO - 'LANGUAGE': 'en_US:en', 04:06:04 INFO - 'LOGNAME': 'cltbld', 04:06:04 INFO - 'MAIL': '/var/mail/cltbld', 04:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:04 INFO - 'MOZ_NO_REMOTE': '1', 04:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:04 INFO - 'NO_EM_RESTART': '1', 04:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:04 INFO - 'PWD': '/builds/slave/test', 04:06:04 INFO - 'SHELL': '/bin/bash', 04:06:04 INFO - 'SHLVL': '1', 04:06:04 INFO - 'TERM': 'linux', 04:06:04 INFO - 'TMOUT': '86400', 04:06:04 INFO - 'USER': 'cltbld', 04:06:04 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 04:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:04 INFO - '_': '/tools/buildbot/bin/python'} 04:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:04 INFO - Downloading/unpacking blobuploader==1.2.4 04:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:06 INFO - Downloading blobuploader-1.2.4.tar.gz 04:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:06:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:06:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:07 INFO - Downloading docopt-0.6.1.tar.gz 04:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:06:07 INFO - Installing collected packages: blobuploader, requests, docopt 04:06:07 INFO - Running setup.py install for blobuploader 04:06:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:06:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:06:07 INFO - Running setup.py install for requests 04:06:07 INFO - Running setup.py install for docopt 04:06:07 INFO - Successfully installed blobuploader requests docopt 04:06:07 INFO - Cleaning up... 04:06:07 INFO - Return code: 0 04:06:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:07 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 0x7f74cd2f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b65410>, '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 0x1b66310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b667a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:06:07 INFO - Using env: {'DISPLAY': ':0', 04:06:07 INFO - 'HOME': '/home/cltbld', 04:06:07 INFO - 'LANG': 'en_US.UTF-8', 04:06:07 INFO - 'LANGUAGE': 'en_US:en', 04:06:07 INFO - 'LOGNAME': 'cltbld', 04:06:07 INFO - 'MAIL': '/var/mail/cltbld', 04:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:07 INFO - 'MOZ_NO_REMOTE': '1', 04:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:07 INFO - 'NO_EM_RESTART': '1', 04:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:07 INFO - 'PWD': '/builds/slave/test', 04:06:07 INFO - 'SHELL': '/bin/bash', 04:06:07 INFO - 'SHLVL': '1', 04:06:07 INFO - 'TERM': 'linux', 04:06:07 INFO - 'TMOUT': '86400', 04:06:07 INFO - 'USER': 'cltbld', 04:06:07 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 04:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:07 INFO - '_': '/tools/buildbot/bin/python'} 04:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:08 INFO - Running setup.py (path:/tmp/pip-E_YtvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:08 INFO - Running setup.py (path:/tmp/pip-qXaYJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:08 INFO - Running setup.py (path:/tmp/pip-u0GCyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:08 INFO - Running setup.py (path:/tmp/pip-FUezuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:08 INFO - Running setup.py (path:/tmp/pip-aeAIVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:08 INFO - Running setup.py (path:/tmp/pip-93VLT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:08 INFO - Running setup.py (path:/tmp/pip-EVxksi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:08 INFO - Running setup.py (path:/tmp/pip-iqIf15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:08 INFO - Running setup.py (path:/tmp/pip-pyCSRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:08 INFO - Running setup.py (path:/tmp/pip-dpXF06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:08 INFO - Running setup.py (path:/tmp/pip-0T0Kca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:08 INFO - Running setup.py (path:/tmp/pip-6vto6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:09 INFO - Running setup.py (path:/tmp/pip-fbMA3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:09 INFO - Running setup.py (path:/tmp/pip-GecNBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:09 INFO - Running setup.py (path:/tmp/pip-JewjgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:09 INFO - Running setup.py (path:/tmp/pip-Ec5PNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:09 INFO - Running setup.py (path:/tmp/pip-1Obg64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:06:09 INFO - Running setup.py install for manifestparser 04:06:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:06:09 INFO - Running setup.py install for mozcrash 04:06:09 INFO - Running setup.py install for mozdebug 04:06:09 INFO - Running setup.py install for mozdevice 04:06:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:06:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:06:09 INFO - Running setup.py install for mozfile 04:06:09 INFO - Running setup.py install for mozhttpd 04:06:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:06:10 INFO - Running setup.py install for mozinfo 04:06:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:06:10 INFO - Running setup.py install for mozInstall 04:06:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:06:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:06:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:06:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:06:10 INFO - Running setup.py install for mozleak 04:06:10 INFO - Running setup.py install for mozlog 04:06:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:06:10 INFO - Running setup.py install for moznetwork 04:06:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:06:10 INFO - Running setup.py install for mozprocess 04:06:10 INFO - Running setup.py install for mozprofile 04:06:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:06:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:06:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:06:10 INFO - Running setup.py install for mozrunner 04:06:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:06:10 INFO - Running setup.py install for mozscreenshot 04:06:10 INFO - Running setup.py install for moztest 04:06:11 INFO - Running setup.py install for mozversion 04:06:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:06:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:06:11 INFO - Cleaning up... 04:06:11 INFO - Return code: 0 04:06:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06: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')]} 04:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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')]} 04:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:11 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 0x7f74cd2f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b65410>, '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 0x1b66310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b667a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:06:11 INFO - Using env: {'DISPLAY': ':0', 04:06:11 INFO - 'HOME': '/home/cltbld', 04:06:11 INFO - 'LANG': 'en_US.UTF-8', 04:06:11 INFO - 'LANGUAGE': 'en_US:en', 04:06:11 INFO - 'LOGNAME': 'cltbld', 04:06:11 INFO - 'MAIL': '/var/mail/cltbld', 04:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:11 INFO - 'MOZ_NO_REMOTE': '1', 04:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:11 INFO - 'NO_EM_RESTART': '1', 04:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:11 INFO - 'PWD': '/builds/slave/test', 04:06:11 INFO - 'SHELL': '/bin/bash', 04:06:11 INFO - 'SHLVL': '1', 04:06:11 INFO - 'TERM': 'linux', 04:06:11 INFO - 'TMOUT': '86400', 04:06:11 INFO - 'USER': 'cltbld', 04:06:11 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 04:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:11 INFO - '_': '/tools/buildbot/bin/python'} 04:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:11 INFO - Running setup.py (path:/tmp/pip-D8dNef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:11 INFO - Running setup.py (path:/tmp/pip-5C6vjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:11 INFO - Running setup.py (path:/tmp/pip-kjPLkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:11 INFO - Running setup.py (path:/tmp/pip-VbSCww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:11 INFO - Running setup.py (path:/tmp/pip-QpPX_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:11 INFO - Running setup.py (path:/tmp/pip-2O3Uo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:11 INFO - Running setup.py (path:/tmp/pip-DLldkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:11 INFO - Running setup.py (path:/tmp/pip-1ZBorE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:11 INFO - Running setup.py (path:/tmp/pip-nc2oiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:12 INFO - Running setup.py (path:/tmp/pip-FJQgoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:12 INFO - Running setup.py (path:/tmp/pip-yGahmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:12 INFO - Running setup.py (path:/tmp/pip-EHk2C7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:12 INFO - Running setup.py (path:/tmp/pip-ZMhBEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:12 INFO - Running setup.py (path:/tmp/pip-PeE7vQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:12 INFO - Running setup.py (path:/tmp/pip-sr9eHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:12 INFO - Running setup.py (path:/tmp/pip-r5JOad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:12 INFO - Running setup.py (path:/tmp/pip-nRkSr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06:14 INFO - Downloading blessings-1.6.tar.gz 04:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:06:14 INFO - Installing collected packages: blessings 04:06:14 INFO - Running setup.py install for blessings 04:06:14 INFO - Successfully installed blessings 04:06:14 INFO - Cleaning up... 04:06:14 INFO - Return code: 0 04:06:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:06:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:14 INFO - Reading from file tmpfile_stdout 04:06:14 INFO - Current package versions: 04:06:14 INFO - argparse == 1.2.1 04:06:14 INFO - blessings == 1.6 04:06:14 INFO - blobuploader == 1.2.4 04:06:14 INFO - docopt == 0.6.1 04:06:14 INFO - manifestparser == 1.1 04:06:14 INFO - mozInstall == 1.12 04:06:14 INFO - mozcrash == 0.17 04:06:14 INFO - mozdebug == 0.1 04:06:14 INFO - mozdevice == 0.48 04:06:14 INFO - mozfile == 1.2 04:06:14 INFO - mozhttpd == 0.7 04:06:14 INFO - mozinfo == 0.9 04:06:14 INFO - mozleak == 0.1 04:06:14 INFO - mozlog == 3.1 04:06:14 INFO - moznetwork == 0.27 04:06:14 INFO - mozprocess == 0.22 04:06:14 INFO - mozprofile == 0.28 04:06:14 INFO - mozrunner == 6.11 04:06:14 INFO - mozscreenshot == 0.1 04:06:14 INFO - mozsystemmonitor == 0.0 04:06:14 INFO - moztest == 0.7 04:06:14 INFO - mozversion == 1.4 04:06:14 INFO - psutil == 3.1.1 04:06:14 INFO - requests == 1.2.3 04:06:14 INFO - wsgiref == 0.1.2 04:06:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:14 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 0x7f74cd2f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b65410>, '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 0x1b66310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b667a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:06:14 INFO - Using env: {'DISPLAY': ':0', 04:06:14 INFO - 'HOME': '/home/cltbld', 04:06:14 INFO - 'LANG': 'en_US.UTF-8', 04:06:14 INFO - 'LANGUAGE': 'en_US:en', 04:06:14 INFO - 'LOGNAME': 'cltbld', 04:06:14 INFO - 'MAIL': '/var/mail/cltbld', 04:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:14 INFO - 'MOZ_NO_REMOTE': '1', 04:06:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:14 INFO - 'NO_EM_RESTART': '1', 04:06:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:14 INFO - 'PWD': '/builds/slave/test', 04:06:14 INFO - 'SHELL': '/bin/bash', 04:06:14 INFO - 'SHLVL': '1', 04:06:14 INFO - 'TERM': 'linux', 04:06:14 INFO - 'TMOUT': '86400', 04:06:14 INFO - 'USER': 'cltbld', 04:06:14 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 04:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:14 INFO - '_': '/tools/buildbot/bin/python'} 04:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:06:15 INFO - Cleaning up... 04:06:15 INFO - Return code: 0 04:06:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f74cd2f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b65410>, '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 0x1b66310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b667a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:06:15 INFO - Using env: {'DISPLAY': ':0', 04:06:15 INFO - 'HOME': '/home/cltbld', 04:06:15 INFO - 'LANG': 'en_US.UTF-8', 04:06:15 INFO - 'LANGUAGE': 'en_US:en', 04:06:15 INFO - 'LOGNAME': 'cltbld', 04:06:15 INFO - 'MAIL': '/var/mail/cltbld', 04:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:15 INFO - 'MOZ_NO_REMOTE': '1', 04:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:15 INFO - 'NO_EM_RESTART': '1', 04:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:15 INFO - 'PWD': '/builds/slave/test', 04:06:15 INFO - 'SHELL': '/bin/bash', 04:06:15 INFO - 'SHLVL': '1', 04:06:15 INFO - 'TERM': 'linux', 04:06:15 INFO - 'TMOUT': '86400', 04:06:15 INFO - 'USER': 'cltbld', 04:06:15 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 04:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:15 INFO - '_': '/tools/buildbot/bin/python'} 04:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:15 INFO - Downloading/unpacking jsonschema 04:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:06:17 INFO - Downloading/unpacking functools32 (from jsonschema) 04:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:17 INFO - Downloading functools32-3.2.3-2.tar.gz 04:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:06:17 INFO - warning: no files found matching '*.txt' 04:06:17 INFO - no previously-included directories found matching 'build' 04:06:17 INFO - no previously-included directories found matching 'dist' 04:06:17 INFO - no previously-included directories found matching '.git*' 04:06:17 INFO - Installing collected packages: jsonschema, functools32 04:06:17 INFO - Running setup.py install for functools32 04:06:17 INFO - warning: no files found matching '*.txt' 04:06:17 INFO - no previously-included directories found matching 'build' 04:06:17 INFO - no previously-included directories found matching 'dist' 04:06:17 INFO - no previously-included directories found matching '.git*' 04:06:17 INFO - Successfully installed jsonschema functools32 04:06:17 INFO - Cleaning up... 04:06:17 INFO - Return code: 0 04:06:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:17 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 0x7f74cd2f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b65410>, '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 0x1b66310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b667a0>, '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': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:06:17 INFO - Using env: {'DISPLAY': ':0', 04:06:17 INFO - 'HOME': '/home/cltbld', 04:06:17 INFO - 'LANG': 'en_US.UTF-8', 04:06:17 INFO - 'LANGUAGE': 'en_US:en', 04:06:17 INFO - 'LOGNAME': 'cltbld', 04:06:17 INFO - 'MAIL': '/var/mail/cltbld', 04:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:17 INFO - 'MOZ_NO_REMOTE': '1', 04:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:17 INFO - 'NO_EM_RESTART': '1', 04:06:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:17 INFO - 'PWD': '/builds/slave/test', 04:06:17 INFO - 'SHELL': '/bin/bash', 04:06:17 INFO - 'SHLVL': '1', 04:06:17 INFO - 'TERM': 'linux', 04:06:17 INFO - 'TMOUT': '86400', 04:06:17 INFO - 'USER': 'cltbld', 04:06:17 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 04:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:17 INFO - '_': '/tools/buildbot/bin/python'} 04:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:17 INFO - Downloading/unpacking flake8 04:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:06:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:06:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:06:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:06:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:06:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:06:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:06:20 INFO - no previously-included directories found matching 'docs/_build' 04:06:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:06:20 INFO - Running setup.py install for pep8 04:06:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:06:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:06:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:06:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:06:20 INFO - no previously-included directories found matching 'docs/_build' 04:06:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:06:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:06:20 INFO - Cleaning up... 04:06:20 INFO - Return code: 0 04:06:20 INFO - Running post-action listener: _resource_record_post_action 04:06:20 INFO - Running post-action listener: _start_resource_monitoring 04:06:20 INFO - Starting resource monitoring. 04:06:20 INFO - ##### 04:06:20 INFO - ##### Running install step. 04:06:20 INFO - ##### 04:06:20 INFO - Running pre-action listener: _resource_record_pre_action 04:06:20 INFO - Running main action method: install 04:06:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:21 INFO - Reading from file tmpfile_stdout 04:06:21 INFO - Detecting whether we're running mozinstall >=1.0... 04:06:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:06:21 INFO - Reading from file tmpfile_stdout 04:06:21 INFO - Output received: 04:06:21 INFO - Usage: mozinstall [options] installer 04:06:21 INFO - Options: 04:06:21 INFO - -h, --help show this help message and exit 04:06:21 INFO - -d DEST, --destination=DEST 04:06:21 INFO - Directory to install application into. [default: 04:06:21 INFO - "/builds/slave/test"] 04:06:21 INFO - --app=APP Application being installed. [default: firefox] 04:06:21 INFO - mkdir: /builds/slave/test/build/application 04:06:21 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'] 04:06:21 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 04:06:36 INFO - Reading from file tmpfile_stdout 04:06:36 INFO - Output received: 04:06:36 INFO - /builds/slave/test/build/application/firefox/firefox 04:06:36 INFO - Running post-action listener: _resource_record_post_action 04:06:36 INFO - ##### 04:06:36 INFO - ##### Running run-tests step. 04:06:36 INFO - ##### 04:06:36 INFO - Running pre-action listener: _resource_record_pre_action 04:06:36 INFO - Running main action method: run_tests 04:06:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:06:36 INFO - Python 2.7.3 04:06:36 INFO - Return code: 0 04:06:36 INFO - grabbing minidump binary from tooltool 04:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:36 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 0x1b65410>, '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 0x1b66310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b667a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:06:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:06:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:06:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:06:36 INFO - Return code: 0 04:06:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:06:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:06:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:06:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:06:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:06:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:06:37 INFO - Return code: 0 04:06:37 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:06:37 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:06:37 INFO - Using env: {'DISPLAY': ':0', 04:06:37 INFO - 'HOME': '/home/cltbld', 04:06:37 INFO - 'LANG': 'en_US.UTF-8', 04:06:37 INFO - 'LANGUAGE': 'en_US:en', 04:06:37 INFO - 'LOGNAME': 'cltbld', 04:06:37 INFO - 'MAIL': '/var/mail/cltbld', 04:06:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:37 INFO - 'MOZ_NO_REMOTE': '1', 04:06:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:37 INFO - 'NO_EM_RESTART': '1', 04:06:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:37 INFO - 'PWD': '/builds/slave/test', 04:06:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:37 INFO - 'SHELL': '/bin/bash', 04:06:37 INFO - 'SHLVL': '1', 04:06:37 INFO - 'TERM': 'linux', 04:06:37 INFO - 'TMOUT': '86400', 04:06:37 INFO - 'USER': 'cltbld', 04:06:37 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524', 04:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:37 INFO - '_': '/tools/buildbot/bin/python'} 04:06:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:06:37 INFO - mozversion application_buildid: 20160510142413 04:06:37 INFO - mozversion application_changeset: 1dd42a351054c5b697873d647169019d4d77d762 04:06:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:06:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:06:37 INFO - mozversion application_name: Firefox 04:06:37 INFO - mozversion application_remotingname: firefox-dev 04:06:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:06:37 INFO - mozversion application_vendor: Mozilla 04:06:37 INFO - mozversion application_version: 48.0a2 04:06:37 INFO - mozversion platform_buildid: 20160510142413 04:06:37 INFO - mozversion platform_changeset: 1dd42a351054c5b697873d647169019d4d77d762 04:06:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:06:37 INFO - mozversion platform_version: 48.0a2 04:06:37 INFO - using testdate: 1462964797 04:06:37 INFO - actual date: 1462964797 04:06:37 INFO - starting webserver on 'localhost:58049' 04:06:37 INFO - SUITE-START | Running 2 tests 04:06:37 INFO - TEST-START | dromaeo_css 04:06:37 INFO - operating with platform_type : linux_ 04:06:37 INFO - Initialising browser for dromaeo_css test... 04:06:37 INFO - TEST-INFO | started process 21859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTsX1cv/profile http://localhost:58049/getInfo.html) 04:06:42 INFO - PROCESS | 21859 | __metrics Screen width/height:1600/1200 04:06:42 INFO - PROCESS | 21859 | colorDepth:24 04:06:42 INFO - PROCESS | 21859 | Browser inner width/height: 1024/697 04:06:42 INFO - PROCESS | 21859 | __metrics 04:06:43 ERROR - PROCESS | 21859 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:06:44 INFO - TEST-INFO | 21859: exit 0 04:06:44 INFO - Browser initialized. 04:06:44 INFO - Running cycle 1/1 for dromaeo_css test... 04:06:44 INFO - TEST-INFO | started process 21950 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTsX1cv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:55 INFO - PROCESS | 21950 | RSS: Main: 141434880 04:06:55 INFO - PROCESS | 21950 | 04:07:46 INFO - PROCESS | 21950 | 1462964866944 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:09:54 INFO - PROCESS | 21950 | Cycle 1(1): loaded http://localhost:58049/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58049/tests/dromaeo/cssquery-ext.html) 04:09:55 INFO - PROCESS | 21950 | RSS: Main: 250155008 04:09:55 INFO - PROCESS | 21950 | 04:12:58 INFO - PROCESS | 21950 | Cycle 1(1): loaded http://localhost:58049/tests/dromaeo/cssquery-ext.html (next: http://localhost:58049/tests/dromaeo/cssquery-jquery.html) 04:12:58 INFO - PROCESS | 21950 | RSS: Main: 225411072 04:12:58 INFO - PROCESS | 21950 | 04:16:00 INFO - PROCESS | 21950 | Cycle 1(1): loaded http://localhost:58049/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58049/tests/dromaeo/cssquery-mootools.html) 04:16:01 INFO - PROCESS | 21950 | RSS: Main: 224141312 04:16:01 INFO - PROCESS | 21950 | 04:19:03 INFO - PROCESS | 21950 | Cycle 1(1): loaded http://localhost:58049/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58049/tests/dromaeo/cssquery-prototype.html) 04:19:03 INFO - PROCESS | 21950 | RSS: Main: 225050624 04:19:03 INFO - PROCESS | 21950 | 04:22:06 INFO - PROCESS | 21950 | Cycle 1(1): loaded http://localhost:58049/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58049/tests/dromaeo/cssquery-yui.html) 04:22:06 INFO - PROCESS | 21950 | RSS: Main: 214712320 04:22:06 INFO - PROCESS | 21950 | 04:25:09 INFO - PROCESS | 21950 | Cycle 1(1): loaded http://localhost:58049/tests/dromaeo/cssquery-yui.html (next: http://localhost:58049/tests/dromaeo/cssquery-dojo.html) 04:25:09 INFO - PROCESS | 21950 | RSS: Main: 240316416 04:25:09 INFO - PROCESS | 21950 | 04:25:09 INFO - PROCESS | 21950 | __start_tp_report 04:25:09 INFO - PROCESS | 21950 | _x_x_mozilla_page_load 04:25:09 INFO - PROCESS | 21950 | _x_x_mozilla_page_load_details 04:25:09 INFO - PROCESS | 21950 | |i|pagename|runs| 04:25:09 INFO - PROCESS | 21950 | |0;dojo.html;3298.1424829544317;3340.749443791715;3361.630220675726;3373.3927892979254;3386.2211691311;5510.972445137773;5529.91705124423;5548.556115510754;5549.1676248562735;5570.359408668004;5513.889722205554;5536;5543.417941116175;5558.916616250749;5577.888442231153;4846.4911184325665;5110.974445127778;5134.614903882205;5184.688918664892;5214.687118772886;4874.341963834872;4890.14422476067;4940.901181976358;4943.826966056189;4945.282933974571;4899.240617704261;5066.97466512667;5134.871628209287;5168.664036837612;5186.974065129669;5104.2088476286235;5130.51260130287;5132.640715149941;5138.794448222104;5170.508801663836;4919;4989.126902791997;5022.196448568248;5025.045241404122;5067.721275329855;5339.145736682112;5370.033393989081;5401.351837779492;5420.34955805302;5428.077226871442;5776.422357764232;5792.855178620568;5795.82612521625;5800.158976948319;5800.9129863052085;5757.510611598019;5833;5834.883302333929;5877.353491115974;5899.439553242435;5416.160495123262;5453.672779633234;5458.6724796512335;5461.208124821918;5462.918056229159;5804.535637149018;5959.0763431668165;5966.254218222723;5966.731497082642;5967.283925928829;5787.681677507693;5851.561132915049;5875.588708790429;5888.293404791367;5926.61477004002;5697.173909783059;5702.971485142548;5704;5712.514436272881;5716.456936591017;5677.233573467529;5680.11958146488;5684.204211410406;5690.6870122142855;5859.267591551056;5802.88394232113;5838.182654428383;5847.736851841677;5852.678102704393;5883.02930016551;4458.910821783546;4472.686911916199;4473.843415480507;4478.2610869206865;4506.188886000486;3971.920561588752;3984.442178095069;4003.5996400360314;4005.599440055971;4047.2917239483563;5543.944560554423;5564.666120032811;5571;5573.108302671553;5600.35595906476;5865.794697185664;5866.442687944638;5870.530357571384;5878.882422351615;5885.264341957255;5465.535429488458;5511.421300763443;5566.666000040011;5629.493345598916;5636.915446268227;4740.525947405232;4763.404574428197;4766.785494652749;4768.499307572724;4790.712557246577;5980.073088671263;6038.184845045863;6039.879202416015;6040.788572399945;6047.909281360783;5766.077427611646;5942.257217847769;5979.850503737442;5982.551308651956;5989.970050149721;6026.15633811258;6037;6048.667323297261;6055.848603784764;6061.636301821904;5604.551635869202;5752.971235143965;5755.65466072037;5756.94243057564;5770.076787713946;5818.9127163093435;5853.590248682552;5866.061430171152;5867.20792692981;5901.9966605678;5661.094224923992;5667.319921609434;5671.914921276101;5694.601377903673;5697.430256974435;5516.668999860021;5651.943480565306;5656.688882111359;5666.490015898424;5759.740811663569;5595.328560572594;5615.859603509945;5626.071698169756;5628.380878103487;5665.065264231355;5734.598578099493;5775.33583637887;5791;5796.101604251347;5798.217240672455;5487.5609951203005;5659.688717120598;5667.263255776723;5672.461116193955;5736.512396446182 04:25:09 INFO - PROCESS | 21950 | |1;ext.html;615.9106929495223;659.6866488418001;660.7092879133182;671.4259308291414;677.2820809941466;32352.67647323526;39588;40526;40544.79727601358;40580.59419405805;44052.33921491172;44536.33195502062;44549.55450445494;44551.55448445515;44622.55377446225;7814.570198639072;8593.097724738891;8702.912970870306;8753;10163.745906352326;10497.580096796119;10596.735081622945;10602.78794424111;10608.946955265214;10620.415877126756;10835;10919.071878890303;10927.945360273188;10928.071113955324;10930;8023.237792409712;8212.219839115274;10248.846267305997;10398.636047738293;10771.730706732355;10399.220058495568;10517.737056573647;10528.842067368996;10531.578736850517;10532.315399499008;39569.20861582752;40212.59787402118;40314.395284070764;40330.596694032974;40387.19225615471;3755.755875868087;3769.6607305342377;3774.6036666149935;3877.321468742987;3919.8236079376497;33592.1601959953;33979.15052123692;34168.82915585406;34243.315133697186;34622;4534.909301813978;4664.720116793003;4676.392069031004;4697.859064228044;4725.716457012591;323225;328347;328483;328915;329340;42319.57680423218;65343.34656653373;67056;67146.66426667836;67151;40790.38814417786;40911.977200570225;41075.178496430504;41293.58706412958;41338.1732365351;17838.5540361492;18118.909405452887;18135.45593632193;18143.546411339557;18150.636987260183;13571.52499662507;14795.926020370045;15227.314770835117;15249.847501524842;15300.311485983157;9421.952890235505;9466.479343636167;9478.431294122374;9515.666951656658;9526;3582.30145121704;3622.945655815165;3629.292288003814;3710.313591985437;3719.088823238324;1095.5562996986234;1122.5734220996133;1210.267787988272;1297.8312819333426;1316.6701631352403;32983;33221;33424;33657;33693.15767105793;1226.399064458427;1234.9012079033655;1245.0724210463081;1307.6469353274754;1340.8994325425633;17423.12884355777;17749.822501775074;17941;18155.183016764015;18294.542636434195;451001;451024;453762;454931;455420;61516.38483615196;62180.37819621746;62181;62213;62244.68877655583;1308.3523655790445;1534.4706076403622;1542.0362273579012;1581.7627355896707;1629.413411171977;30171.547426789053;31286.687133128376;31582.210444739067;32157;32514;46189.76905115453;60941;61747.691261543405;62249;62423;440423;444921;451427;451452;452378;39671;46434.767826160656;48005.51994480011;48032.5196748028;48511.5148848507;45260.09479810319;45541;46356;46674.53325466702;47670;41295;41363.7931810339;42465.787671061444;42822.571774283104;43521;41963.37054944117;42130.36804447997;42774;42820.35769463398;43118.35322470103;43075.353869692604;43706;44175;44294.77852610716;44691.10617787691;36081;36950.07624809401;38224;38533;38535.61464385432;28758;29178.270543236587;29217;29221.123366299045;29378 04:25:09 INFO - PROCESS | 21950 | |2;jquery.html;431.8812326610182;435.0667817531397;438.42566238227914;447.3602748070259;452.8098198756522;18309.633807323862;19023.52441188971;19242.422727318168;20212;20683.65556238847;19821.306254281102;20251.797482025177;20423.18307267711;20495.07772150253;20506.384808455732;5691.658500489973;5714.828555143353;5866.501347385477;5902.468777809996;5904.645721256717;4246.893827654302;5808.506276966463;5808.535317174637;6081.817545473643;6365.58623689461;6331.335209802974;6350.777722779703;6361.6183029018175;6362.268339140988;6362.459190968773;6286.685665716719;6316.3683631636695;6328.050792381179;6374.617522948592;6414.647194404282;3942.231264903345;5531.25328080712;5776.422357764232;5785.045467497858;5802.5938184327115;22369.217077402212;22378.104875804947;22456.663150052762;22702.54594908109;23868.40328991772;2361.6575596538405;2383.9642405363934;2431.270618814349;3159.3997140543224;3269.5095735639607;10822.458877056115;11060.336379817156;11072.28030178044;12770.936145319307;14257.714845703027;2047.119738512439;2091.9267825626184;2111.9788802111934;2129.818965387944;2150.860194087379;82417.58791206006;83769.16230837675;83834.58082709547;84232.99999999939;85054;11380.772384552263;11513.424328783527;11595.478203480863;11605;11641;16030.438934637232;16265.430709925096;16391;16402.917985409997;16414;8447.619857106445;8627.40393027292;8628.654853805903;8675.436096653824;8801.823963520821;8377.6230069647;8479.491230526188;8481.363897707697;8792.42849214799;8802.07578204292;4749.786259618326;4793.065352256276;4871.658983871095;4907.582855457326;5007.9499205008215;1838.5771272607376;2021.938482296806;2122.2466024561368;3380.645032271625;3384.7799893006877;1014.5789497358513;1114.9777004460027;1151.9424028798526;1170.777552265067;1188.2395267029108;18346.449606511826;18704.906475467535;19006.95461749617;19051.61896762057;19708.70436943447;1024.533837104116;1082.2045796339685;1084.9403282819521;1150.4017910686564;1156.9363684997406;10725.51735171919;10859.83710244347;10903;10909.454527273605;10927.562897484171;543103;543528;553768;574899;578867;88473.11526884777;92402;93012;93732.53133734288;94087;1062.3625824505234;1068.8450174724621;1092.830611255241;1094.7974624694457;1095.2059756676506;16881.831181688518;16996.23516941716;17039.48881533556;17052.403165889133;17187.82812171912;40441.39337909993;41005.589944100175;41661.79169104135;41776;42397.78801105975;58920.705396472746;59976.700116500884;60058.69970650119;60172.69913650404;60673.69663151656;9209.907900921173;9229;9254.722358329262;9264.258859291376;9336.206422454168;10130.8480372793;12724.872751272369;13698.794518082037;13984.370703318578;14020.929895350459;6446.419822216023;10178.694639160836;11914.285142891455;12036.157468977088;12238.571649992207;11758.82361764557;11841.407929603312;12075.27548347102;12314.445849936596;12314.507419703112;12142;12278.631641050782;12418.689532761753;12517.248965062125;12576;9025.638974440948;9056.275497960016;9194.862077068716;9217.539123043955;9289.814203715752;9225.169734723908;11755;11856.288622682667;12085.818712719492;12245.387730613611 04:25:09 INFO - PROCESS | 21950 | |3;mootools.html;1317.196510128822;1545.0343535290444;1561.898476599021;1754.789425268968;1876.8873867567938;7598.088229412471;7796.220377962201;7845.4900431471915;7847.2152784721575;7897.052353717548;7662.885056724153;7828.217178282169;7830.765077047683;7844.607769611525;7851.960740196305;2077.45986043629;2271.659251112338;2336.0889253191226;2341.683872677184;2354.75275096115;2382.5592265430864;2390.175389490623;2390.2351247600773;2393.5930891748444;2395.2215529952746;2302.343832007878;2354;2358.151065616377;2358.516504116652;2362.787349138577;2045.9897700511476;2232.910683572655;2270.625346817773;2278.943026424336;2279.190887235041;2275.5448910217856;2275.8179345652306;2296.379977406091;2301.9309420717404;2350.518143780538;7751.30238278552;7751.418643601696;7799.688012479494;7806.960965195138;7808.945792318021;4894.2903279024695;5037.647364684473;5043.193089105725;5045.217991211368;5084.313617661605;3365.4110530657035;3366.7979921204806;3387.5426817379584;3430.0395889150827;3443.9483407748903;1261.400834603556;1275.489804078367;1278.207511342964;1280.3086333379963;1346.764316244663;10834.837477437844;10842.186835987333;10848.78302433947;10849.67450976472;10878.72803179919;4195.811188496525;4329.956700433018;4348.934765978513;4397.978010109929;4405.867823965286;9327.673531426368;9425.717228483156;9428.15146636806;9431.764205894908;9442.15020648145;4542.863714088583;4981.9252711209365;4982.526659967298;4982.551570358685;4983.626228032912;4615.699979501322;4618.468876079294;4637.768111594407;4680.4149481314835;4705.64707646921;3910.6284902934176;3980.7810570418324;4025.1081991463966;4048.109415928491;4091.468109145792;1291.1607455154226;1304.8368953880765;1313.3761463305045;1316.5128902306017;1321.14125818217;1070.4112737994071;1075.295681328731;1077.4074259157433;1082.5723839083676;1086.3970496374588;5702.942970570324;5775.162601422854;5862.208601838697;5911.172435858897;5911.733971971272;478.54299144317787;497.9004199160182;500.96493245472465;501.2331133365883;505.2547492448682;3817.599152089046;3987.5813039631003;4007.539132999684;4055.1889622075114;4061.147159096623;9840.507974601242;10157.288989770794;10317.742056448498;10323;10331.070203681706;9923;9992.500374981222;10076.29465937392;10162.542685579167;10176.440295783803;7934.841303173905;7960.283574478209;8037.7588672339925;8048.798780030546;8049.436539442183;5782.2194003808945;5888.823335299948;5910.911336330045;5926.348101708722;6046.5767396281835;9072.95463522678;9154.908450915405;9164.6792362267;9273.67542136022;9317.6272949084;9125.726228213165;9290;9297.488638124698;9488.478133702436;9511.57197926081;6525.608463492205;7055.082839231072;7246.275372462712;7501.88747168782;7570.9242907570215;7955.960220198862;7992.6802927884555;8001.8399632008195;8049.476784009021;8059.597020148852;7123.7862864112085;7126.893096603659;7129.857402851811;7234.710611575478;7512.962435187789;7267.709291628275;7286.890696639449;7305.545754086233;7320.8535829282055;7365.226651201547;6712.4294434971625;6727.73089076451;6756.4257038150345;6761.661916904037;6778.2543920167755;5127.564157046693;5239.748372540181;5249.160134378634;5323.228131920772;5335.466453354788;5358.598105142052;5371.785128594813;5383.2463455117095;5405;5441.075017246998 04:25:09 INFO - PROCESS | 21950 | |4;prototype.html;342.66076584181656;344.5279966445968;353.2951761236334;365.4718931144497;372.0661140537251;6319;6378.681065946702;6384.904226436607;6410.647414392207;6414.358564143595;6311.621302721828;6312.6212427254395;6330.8100756977365;6332.461740752042;6334;4601.148787474328;4716.575508204261;4797.40032495938;4812.254100614393;4816.686915350491;4834.879128021792;4838.701616732042;4869.586085182746;4877.414710234777;4878.70727756334;4637.930431043537;4827.58965487934;4836.879078023042;4837.709737415748;4849.0301939612045;4699.7415142167165;4839.128956787777;4842.15262329091;4843.685160464576;4849.272609108627;4254.446921900133;4257.340112282601;4257.872263832059;4268.679849011305;4273.9358909616385;6041.667708276043;6054.666993315366;6056.6063205891915;6058.030715085565;6062.393465731585;5638.74625641843;5638.943610563882;5647.8588035299035;5649.887002259973;5653.604247702662;6394.200724909387;6608.504362172808;6611.669416529202;6614.107095542088;6619.702113404908;4566.337881007268;4599.540045995407;4601.585857272828;4603.49361570227;4604.963883126304;6910.965445172792;6985.615791131486;6991.475639327122;6994.790156295319;6996.440284777205;4704.1062198182235;4712.481627021025;4718.8584342469785;4720.504347043579;4720.740359280273;4779.904401911942;4782.95217047832;4790.353302304145;4790.377250957354;4793.976030119827;5534.86162845924;5538.418466061086;5544.833654990357;5555.361133469622;5559.77760889568;6490;6719.563228390237;6732.528722989344;6736.494762892803;6742.325767423316;1644.071099828593;1675.246139237348;1678.8321167883357;1681.1762236504026;1682.528891910267;1027.4554486122368;1068.5245065945735;1087.3693257910393;1097.8133717268083;1099.7745462180235;6184.484801223729;6363.96818015907;6377.553571249968;6383.521235907326;6383.585066970632;6787.185537735503;6847.21257055435;6852.554583952126;6857.7256909723055;6869.347411995853;6375.71309291083;6380.042993550912;6383.265924418658;6386.616802991743;6387.744490220432;3629.8366573504254;3663.2124093320062;3664.193877346979;3667.74325797197;3668.816559172084;6897.517173797786;7038.049863268496;7048.118985126859;7058.435325173974;7065.894011589728;6875.1749790025515;6880.65596720162;6886.552374095668;6891.345322194384;6892;7018.298170183043;7021.473389495808;7023.508354415244;7024.754133605299;7031.613261270679;6752.223494298219;6756.729730810713;6760.459163267025;6764.222114456704;6764.323567643196;6529.7388104475285;6654.268030516736;6671.733130674718;6679.833004174934;6699.665016749241;6991.580505169706;6997.405220556309;7014.579969910373;7019.403350715246;7027.789166325018;4670.042641258466;4671.672982891165;4673.579377856009;4674.439067311944;4675.345451636842;6723.966380168264;6729.057931889637;6734.3602357775935;6735.191776986793;6737.023131645982;6386.137871387489;6555.049517819794;6558.868822623616;6654.268030516542;6658.63377514222;6485.967570162119;6514.54398192122;6518.674066296761;6529.216494020748;6533.052707357501;6396.6481843497195;6404.4876409886165;6407.935920640734;6414.839629009312;6424.100625912282;6540.901886471612;6542.247641521286;6554.573952693059;6559.6064236144075;6560.573562718408;6240.812775616739;6417.903731444126;6419.6790160490855;6420.7431702731365;6432.839179020375 04:25:09 INFO - PROCESS | 21950 | |5;yui.html;827.5283088639475;838.5597561280331;854.1842540373948;907.8910530736313;927.9721608351749;15481.612959676;15742.134182619951;15826.28781704823;15862.920685396557;15873.603159921007;14471.710565788679;14558.854411455883;14577.416903323881;14581.416743330254;14590.635234119152;739.4343327354578;879.2350654930219;883.6288758721337;897.6185121323444;904.4889637354906;887.7381172554079;889.1908363389317;891.2068259249273;891.8216356728681;891.9063498332679;949.6011675096441;950.9001554836747;951.7620594851287;951.9619215231417;953.1516949914582;772.0696560644438;934;944.4805357053627;948.6395169835488;948.9952550237274;697.3967518096861;697.7243988624465;698.333091897242;698.6192525073847;699.6606645776794;15046.849531504764;15056.774148387783;15116.924415377853;15127.470538531208;15133.167675777828;14963.625909352353;15790.289436975363;15805.367785288574;15815.209239537977;15886.841131588651;12073.517059317617;12155.696107597292;12189.746523718386;12212.450439730233;12359.567415140427;4038.192361527677;4040.676745860324;4101.958980410188;4123.793810309473;4180.122174343392;54884.17673734897;55502.05742799023;55526.44473555253;55729.72135139298;58312.70843645755;11265.605703800327;11431.428428578538;11541.422928853524;12029.518819247307;12084.697882552831;19815.801841981684;20695.27566535164;20946.685799713017;20961.79038209629;21008.159673612885;9012.361691725875;9025.187733104052;9063.048379920145;9128.634854605742;9331.300152488455;5127;5132.204508301219;5153.484651534816;5192.1173400522;5209.7916083356995;3460.8788692395647;3517.771344862576;3518.5425894633536;3524.6299138590593;3529.1000794797164;554.2157846647029;619.5229673151738;652.2271108736163;659.9736010559524;660.2736989311719;697.6825544377297;705.8905869590221;716.9677364518609;741.2624438683545;785.5561607691636;9822.214222862154;10022.799544009078;10123.240756943258;10166.390016599027;10239.641612543524;696.095076400677;740.4964624055693;761.702935855017;789.455275859655;815.7185770909027;4463.687541872103;4593.908121837545;4683.484816670163;4702.130105930414;4720.291956206528;65237.347626524075;65914.34085659178;66492;66682;66785;58017.419825801204;58158.418415816144;59690;60109;60325.69837150786;51838.740806295726;51974.740126299126;52139.47860521346;52787.472125278255;53174.468255317726;9122.635094596142;9129.726108216764;9162.404443711137;9245.953770231376;9439.38643988166;39427.80286098551;39604.80197598993;40064.59935400609;40382.596174039056;41137.38293925534;47082.529174707815;49418;50935.49064509307;51108;52139.73930130325;10963.397013164353;11707;11945.402729863647;13002.089853710528;13158.934205328913;13082.28047457399;14095.859041409454;14537.127772333693;14553.92723036378;14936.925315373353;13062.804057938949;13894.791578126134;14057.437702491785;14235.857641423867;14788.482403115839;12447.39140792501;12881.549145779853;13289;13449.327533623475;13687.931560342135;13594.45622175102;13633.795493067413;13851.16892986424;13912.165270083828;14129.858701412853;11482;11532;11659.76680466369;11734.178607497393;11879.703007424538;11025.415601023107;11033.613823516138;11050.613228536962;11156.330620162817;11505.597304094317 04:25:09 INFO - PROCESS | 21950 | __end_tp_report 04:25:09 INFO - PROCESS | 21950 | __start_cc_report 04:25:09 INFO - PROCESS | 21950 | _x_x_mozilla_cycle_collect,898 04:25:09 INFO - PROCESS | 21950 | __end_cc_report 04:25:09 INFO - PROCESS | 21950 | __startTimestamp1462965909292__endTimestamp 04:25:09 INFO - PROCESS | 21950 | 04:25:09 INFO - PROCESS | 21950 | ------- Summary: start ------- 04:25:09 INFO - PROCESS | 21950 | Number of tests: 6 04:25:09 INFO - PROCESS | 21950 | 04:25:09 INFO - PROCESS | 21950 | [#0] dojo.html Cycles:165 Average:5438.21 Median:5651.94 stddev:590.98 (10.5%) stddev-sans-first:568.44 04:25:09 INFO - PROCESS | 21950 | Values: 3298.1 3340.7 3361.6 3373.4 3386.2 5511.0 5529.9 5548.6 5549.2 5570.4 5513.9 5536.0 5543.4 5558.9 5577.9 4846.5 5111.0 5134.6 5184.7 5214.7 4874.3 4890.1 4940.9 4943.8 4945.3 4899.2 5067.0 5134.9 5168.7 5187.0 5104.2 5130.5 5132.6 5138.8 5170.5 4919.0 4989.1 5022.2 5025.0 5067.7 5339.1 5370.0 5401.4 5420.3 5428.1 5776.4 5792.9 5795.8 5800.2 5800.9 5757.5 5833.0 5834.9 5877.4 5899.4 5416.2 5453.7 5458.7 5461.2 5462.9 5804.5 5959.1 5966.3 5966.7 5967.3 5787.7 5851.6 5875.6 5888.3 5926.6 5697.2 5703.0 5704.0 5712.5 5716.5 5677.2 5680.1 5684.2 5690.7 5859.3 5802.9 5838.2 5847.7 5852.7 5883.0 4458.9 4472.7 4473.8 4478.3 4506.2 3971.9 3984.4 4003.6 4005.6 4047.3 5543.9 5564.7 5571.0 5573.1 5600.4 5865.8 5866.4 5870.5 5878.9 5885.3 5465.5 5511.4 5566.7 5629.5 5636.9 4740.5 4763.4 4766.8 4768.5 4790.7 5980.1 6038.2 6039.9 6040.8 6047.9 5766.1 5942.3 5979.9 5982.6 5990.0 6026.2 6037.0 6048.7 6055.8 6061.6 5604.6 5753.0 5755.7 5756.9 5770.1 5818.9 5853.6 5866.1 5867.2 5902.0 5661.1 5667.3 5671.9 5694.6 5697.4 5516.7 5651.9 5656.7 5666.5 5759.7 5595.3 5615.9 5626.1 5628.4 5665.1 5734.6 5775.3 5791.0 5796.1 5798.2 5487.6 5659.7 5667.3 5672.5 5736.5 04:25:09 INFO - PROCESS | 21950 | 04:25:09 INFO - PROCESS | 21950 | [#1] ext.html Cycles:180 Average:58071.81 Median:39578.60 stddev:109231.25 (276.0%) stddev-sans-first:109452.49 04:25:09 INFO - PROCESS | 21950 | Values: 615.9 659.7 660.7 671.4 677.3 32352.7 39588.0 40526.0 40544.8 40580.6 44052.3 44536.3 44549.6 44551.6 44622.6 7814.6 8593.1 8702.9 8753.0 10163.7 10497.6 10596.7 10602.8 10608.9 10620.4 10835.0 10919.1 10927.9 10928.1 10930.0 8023.2 8212.2 10248.8 10398.6 10771.7 10399.2 10517.7 10528.8 10531.6 10532.3 39569.2 40212.6 40314.4 40330.6 40387.2 3755.8 3769.7 3774.6 3877.3 3919.8 33592.2 33979.2 34168.8 34243.3 34622.0 4534.9 4664.7 4676.4 4697.9 4725.7 323225.0 328347.0 328483.0 328915.0 329340.0 42319.6 65343.3 67056.0 67146.7 67151.0 40790.4 40912.0 41075.2 41293.6 41338.2 17838.6 18118.9 18135.5 18143.5 18150.6 13571.5 14795.9 15227.3 15249.8 15300.3 9422.0 9466.5 9478.4 9515.7 9526.0 3582.3 3622.9 3629.3 3710.3 3719.1 1095.6 1122.6 1210.3 1297.8 1316.7 32983.0 33221.0 33424.0 33657.0 33693.2 1226.4 1234.9 1245.1 1307.6 1340.9 17423.1 17749.8 17941.0 18155.2 18294.5 451001.0 451024.0 453762.0 454931.0 455420.0 61516.4 62180.4 62181.0 62213.0 62244.7 1308.4 1534.5 1542.0 1581.8 1629.4 30171.5 31286.7 31582.2 32157.0 32514.0 46189.8 60941.0 61747.7 62249.0 62423.0 440423.0 444921.0 451427.0 451452.0 452378.0 39671.0 46434.8 48005.5 48032.5 48511.5 45260.1 45541.0 46356.0 46674.5 47670.0 41295.0 41363.8 42465.8 42822.6 43521.0 41963.4 42130.4 42774.0 42820.4 43118.4 43075.4 43706.0 44175.0 44294.8 44691.1 36081.0 36950.1 38224.0 38533.0 38535.6 28758.0 29178.3 29217.0 29221.1 29378.0 04:25:09 INFO - PROCESS | 21950 | 04:25:09 INFO - PROCESS | 21950 | [#2] jquery.html Cycles:180 Average:31284.43 Median:2372.81 stddev:91854.55 (3871.1%) stddev-sans-first:92083.02 04:25:09 INFO - PROCESS | 21950 | Values: 431.9 435.1 438.4 447.4 452.8 18309.6 19023.5 19242.4 20212.0 20683.7 19821.3 20251.8 20423.2 20495.1 20506.4 5691.7 5714.8 5866.5 5902.5 5904.6 4246.9 5808.5 5808.5 6081.8 6365.6 6331.3 6350.8 6361.6 6362.3 6362.5 6286.7 6316.4 6328.1 6374.6 6414.6 3942.2 5531.3 5776.4 5785.0 5802.6 22369.2 22378.1 22456.7 22702.5 23868.4 2361.7 2384.0 2431.3 3159.4 3269.5 10822.5 11060.3 11072.3 12770.9 14257.7 2047.1 2091.9 2112.0 2129.8 2150.9 82417.6 83769.2 83834.6 84233.0 85054.0 11380.8 11513.4 11595.5 11605.0 11641.0 16030.4 16265.4 16391.0 16402.9 16414.0 8447.6 8627.4 8628.7 8675.4 8801.8 8377.6 8479.5 8481.4 8792.4 8802.1 4749.8 4793.1 4871.7 4907.6 5007.9 1838.6 2021.9 2122.2 3380.6 3384.8 1014.6 1115.0 1151.9 1170.8 1188.2 18346.4 18704.9 19007.0 19051.6 19708.7 1024.5 1082.2 1084.9 1150.4 1156.9 10725.5 10859.8 10903.0 10909.5 10927.6 543103.0 543528.0 553768.0 574899.0 578867.0 88473.1 92402.0 93012.0 93732.5 94087.0 1062.4 1068.8 1092.8 1094.8 1095.2 16881.8 16996.2 17039.5 17052.4 17187.8 40441.4 41005.6 41661.8 41776.0 42397.8 58920.7 59976.7 60058.7 60172.7 60673.7 9209.9 9229.0 9254.7 9264.3 9336.2 10130.8 12724.9 13698.8 13984.4 14020.9 6446.4 10178.7 11914.3 12036.2 12238.6 11758.8 11841.4 12075.3 12314.4 12314.5 12142.0 12278.6 12418.7 12517.2 12576.0 9025.6 9056.3 9194.9 9217.5 9289.8 9225.2 11755.0 11856.3 12085.8 12245.4 04:25:09 INFO - PROCESS | 21950 | 04:25:09 INFO - PROCESS | 21950 | [#3] mootools.html Cycles:180 Average:5470.41 Median:501.10 stddev:2954.80 (589.7%) stddev-sans-first:2946.60 04:25:09 INFO - PROCESS | 21950 | Values: 1317.2 1545.0 1561.9 1754.8 1876.9 7598.1 7796.2 7845.5 7847.2 7897.1 7662.9 7828.2 7830.8 7844.6 7852.0 2077.5 2271.7 2336.1 2341.7 2354.8 2382.6 2390.2 2390.2 2393.6 2395.2 2302.3 2354.0 2358.2 2358.5 2362.8 2046.0 2232.9 2270.6 2278.9 2279.2 2275.5 2275.8 2296.4 2301.9 2350.5 7751.3 7751.4 7799.7 7807.0 7808.9 4894.3 5037.6 5043.2 5045.2 5084.3 3365.4 3366.8 3387.5 3430.0 3443.9 1261.4 1275.5 1278.2 1280.3 1346.8 10834.8 10842.2 10848.8 10849.7 10878.7 4195.8 4330.0 4348.9 4398.0 4405.9 9327.7 9425.7 9428.2 9431.8 9442.2 4542.9 4981.9 4982.5 4982.6 4983.6 4615.7 4618.5 4637.8 4680.4 4705.6 3910.6 3980.8 4025.1 4048.1 4091.5 1291.2 1304.8 1313.4 1316.5 1321.1 1070.4 1075.3 1077.4 1082.6 1086.4 5702.9 5775.2 5862.2 5911.2 5911.7 478.5 497.9 501.0 501.2 505.3 3817.6 3987.6 4007.5 4055.2 4061.1 9840.5 10157.3 10317.7 10323.0 10331.1 9923.0 9992.5 10076.3 10162.5 10176.4 7934.8 7960.3 8037.8 8048.8 8049.4 5782.2 5888.8 5910.9 5926.3 6046.6 9073.0 9154.9 9164.7 9273.7 9317.6 9125.7 9290.0 9297.5 9488.5 9511.6 6525.6 7055.1 7246.3 7501.9 7570.9 7956.0 7992.7 8001.8 8049.5 8059.6 7123.8 7126.9 7129.9 7234.7 7513.0 7267.7 7286.9 7305.5 7320.9 7365.2 6712.4 6727.7 6756.4 6761.7 6778.3 5127.6 5239.7 5249.2 5323.2 5335.5 5358.6 5371.8 5383.2 5405.0 5441.1 04:25:09 INFO - PROCESS | 21950 | 04:25:09 INFO - PROCESS | 21950 | [#4] prototype.html Cycles:180 Average:5535.29 Median:6378.12 stddev:1655.61 (26.0%) stddev-sans-first:1613.72 04:25:09 INFO - PROCESS | 21950 | Values: 342.7 344.5 353.3 365.5 372.1 6319.0 6378.7 6384.9 6410.6 6414.4 6311.6 6312.6 6330.8 6332.5 6334.0 4601.1 4716.6 4797.4 4812.3 4816.7 4834.9 4838.7 4869.6 4877.4 4878.7 4637.9 4827.6 4836.9 4837.7 4849.0 4699.7 4839.1 4842.2 4843.7 4849.3 4254.4 4257.3 4257.9 4268.7 4273.9 6041.7 6054.7 6056.6 6058.0 6062.4 5638.7 5638.9 5647.9 5649.9 5653.6 6394.2 6608.5 6611.7 6614.1 6619.7 4566.3 4599.5 4601.6 4603.5 4605.0 6911.0 6985.6 6991.5 6994.8 6996.4 4704.1 4712.5 4718.9 4720.5 4720.7 4779.9 4783.0 4790.4 4790.4 4794.0 5534.9 5538.4 5544.8 5555.4 5559.8 6490.0 6719.6 6732.5 6736.5 6742.3 1644.1 1675.2 1678.8 1681.2 1682.5 1027.5 1068.5 1087.4 1097.8 1099.8 6184.5 6364.0 6377.6 6383.5 6383.6 6787.2 6847.2 6852.6 6857.7 6869.3 6375.7 6380.0 6383.3 6386.6 6387.7 3629.8 3663.2 3664.2 3667.7 3668.8 6897.5 7038.0 7048.1 7058.4 7065.9 6875.2 6880.7 6886.6 6891.3 6892.0 7018.3 7021.5 7023.5 7024.8 7031.6 6752.2 6756.7 6760.5 6764.2 6764.3 6529.7 6654.3 6671.7 6679.8 6699.7 6991.6 6997.4 7014.6 7019.4 7027.8 4670.0 4671.7 4673.6 4674.4 4675.3 6724.0 6729.1 6734.4 6735.2 6737.0 6386.1 6555.0 6558.9 6654.3 6658.6 6486.0 6514.5 6518.7 6529.2 6533.1 6396.6 6404.5 6407.9 6414.8 6424.1 6540.9 6542.2 6554.6 6559.6 6560.6 6240.8 6417.9 6419.7 6420.7 6432.8 04:25:09 INFO - PROCESS | 21950 | 04:25:09 INFO - PROCESS | 21950 | [#5] yui.html Cycles:180 Average:15917.65 Median:4638.70 stddev:18275.42 (394.0%) stddev-sans-first:18291.55 04:25:09 INFO - PROCESS | 21950 | Values: 827.5 838.6 854.2 907.9 928.0 15481.6 15742.1 15826.3 15862.9 15873.6 14471.7 14558.9 14577.4 14581.4 14590.6 739.4 879.2 883.6 897.6 904.5 887.7 889.2 891.2 891.8 891.9 949.6 950.9 951.8 952.0 953.2 772.1 934.0 944.5 948.6 949.0 697.4 697.7 698.3 698.6 699.7 15046.8 15056.8 15116.9 15127.5 15133.2 14963.6 15790.3 15805.4 15815.2 15886.8 12073.5 12155.7 12189.7 12212.5 12359.6 4038.2 4040.7 4102.0 4123.8 4180.1 54884.2 55502.1 55526.4 55729.7 58312.7 11265.6 11431.4 11541.4 12029.5 12084.7 19815.8 20695.3 20946.7 20961.8 21008.2 9012.4 9025.2 9063.0 9128.6 9331.3 5127.0 5132.2 5153.5 5192.1 5209.8 3460.9 3517.8 3518.5 3524.6 3529.1 554.2 619.5 652.2 660.0 660.3 697.7 705.9 717.0 741.3 785.6 9822.2 10022.8 10123.2 10166.4 10239.6 696.1 740.5 761.7 789.5 815.7 4463.7 4593.9 4683.5 4702.1 4720.3 65237.3 65914.3 66492.0 66682.0 66785.0 58017.4 58158.4 59690.0 60109.0 60325.7 51838.7 51974.7 52139.5 52787.5 53174.5 9122.6 9129.7 9162.4 9246.0 9439.4 39427.8 39604.8 40064.6 40382.6 41137.4 47082.5 49418.0 50935.5 51108.0 52139.7 10963.4 11707.0 11945.4 13002.1 13158.9 13082.3 14095.9 14537.1 14553.9 14936.9 13062.8 13894.8 14057.4 14235.9 14788.5 12447.4 12881.5 13289.0 13449.3 13687.9 13594.5 13633.8 13851.2 13912.2 14129.9 11482.0 11532.0 11659.8 11734.2 11879.7 11025.4 11033.6 11050.6 11156.3 11505.6 04:25:09 INFO - PROCESS | 21950 | -------- Summary: end -------- 04:25:09 INFO - PROCESS | 21950 | 04:25:09 INFO - TEST-INFO | 21950: exit 0 04:25:09 INFO - TEST-OK | dromaeo_css | took 1112109ms 04:25:09 INFO - TEST-START | kraken 04:25:09 INFO - operating with platform_type : linux_ 04:25:09 INFO - Initialising browser for kraken test... 04:25:10 INFO - TEST-INFO | started process 22143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyvq0tK/profile http://localhost:58049/getInfo.html) 04:25:14 INFO - PROCESS | 22143 | __metrics Screen width/height:1600/1200 04:25:14 INFO - PROCESS | 22143 | colorDepth:24 04:25:14 INFO - PROCESS | 22143 | Browser inner width/height: 1024/697 04:25:14 INFO - PROCESS | 22143 | __metrics 04:25:15 ERROR - PROCESS | 22143 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:25:16 INFO - TEST-INFO | 22143: exit 0 04:25:16 INFO - Browser initialized. 04:25:16 INFO - Running cycle 1/1 for kraken test... 04:25:16 INFO - TEST-INFO | started process 22233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyvq0tK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:28 INFO - PROCESS | 22233 | RSS: Main: 141168640 04:25:28 INFO - PROCESS | 22233 | 04:25:30 INFO - PROCESS | 22233 | Cycle 1(1): loaded http://localhost:58049/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58049/tests/kraken/driver.html?testName=audio-beat-detection) 04:25:31 INFO - PROCESS | 22233 | RSS: Main: 196521984 04:25:31 INFO - PROCESS | 22233 | 04:25:34 INFO - PROCESS | 22233 | Cycle 1(1): loaded http://localhost:58049/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58049/tests/kraken/driver.html?testName=audio-dft) 04:25:34 INFO - PROCESS | 22233 | RSS: Main: 181760000 04:25:34 INFO - PROCESS | 22233 | 04:25:37 INFO - PROCESS | 22233 | Cycle 1(1): loaded http://localhost:58049/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58049/tests/kraken/driver.html?testName=audio-fft) 04:25:38 INFO - PROCESS | 22233 | RSS: Main: 272867328 04:25:38 INFO - PROCESS | 22233 | 04:25:40 INFO - PROCESS | 22233 | Cycle 1(1): loaded http://localhost:58049/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58049/tests/kraken/driver.html?testName=audio-oscillator) 04:25:40 INFO - PROCESS | 22233 | RSS: Main: 178909184 04:25:40 INFO - PROCESS | 22233 | 04:25:42 INFO - PROCESS | 22233 | Cycle 1(1): loaded http://localhost:58049/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58049/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:25:43 INFO - PROCESS | 22233 | RSS: Main: 176918528 04:25:43 INFO - PROCESS | 22233 | 04:25:46 INFO - PROCESS | 22233 | Cycle 1(1): loaded http://localhost:58049/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58049/tests/kraken/driver.html?testName=imaging-darkroom) 04:25:47 INFO - PROCESS | 22233 | RSS: Main: 211685376 04:25:47 INFO - PROCESS | 22233 | 04:25:50 INFO - PROCESS | 22233 | Cycle 1(1): loaded http://localhost:58049/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58049/tests/kraken/driver.html?testName=imaging-desaturate) 04:25:50 INFO - PROCESS | 22233 | RSS: Main: 212320256 04:25:50 INFO - PROCESS | 22233 | 04:25:53 INFO - PROCESS | 22233 | Cycle 1(1): loaded http://localhost:58049/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58049/tests/kraken/driver.html?testName=json-parse-financial) 04:25:54 INFO - PROCESS | 22233 | RSS: Main: 212512768 04:25:54 INFO - PROCESS | 22233 | 04:25:55 INFO - PROCESS | 22233 | Cycle 1(1): loaded http://localhost:58049/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58049/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:25:56 INFO - PROCESS | 22233 | RSS: Main: 191967232 04:25:56 INFO - PROCESS | 22233 | 04:25:58 INFO - PROCESS | 22233 | Cycle 1(1): loaded http://localhost:58049/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58049/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:25:58 INFO - PROCESS | 22233 | RSS: Main: 191574016 04:25:58 INFO - PROCESS | 22233 | 04:26:00 INFO - PROCESS | 22233 | Cycle 1(1): loaded http://localhost:58049/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58049/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:26:01 INFO - PROCESS | 22233 | RSS: Main: 209879040 04:26:01 INFO - PROCESS | 22233 | 04:26:03 INFO - PROCESS | 22233 | Cycle 1(1): loaded http://localhost:58049/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:26:04 INFO - PROCESS | 22233 | RSS: Main: 216797184 04:26:04 INFO - PROCESS | 22233 | 04:26:07 INFO - PROCESS | 22233 | Cycle 1(1): loaded http://localhost:58049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:26:07 INFO - PROCESS | 22233 | RSS: Main: 213970944 04:26:07 INFO - PROCESS | 22233 | 04:26:09 INFO - PROCESS | 22233 | Cycle 1(1): loaded http://localhost:58049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58049/tests/kraken/driver.html?testName=ai-astar) 04:26:09 INFO - PROCESS | 22233 | RSS: Main: 278802432 04:26:09 INFO - PROCESS | 22233 | 04:26:09 INFO - PROCESS | 22233 | __start_tp_report 04:26:09 INFO - PROCESS | 22233 | _x_x_mozilla_page_load 04:26:09 INFO - PROCESS | 22233 | _x_x_mozilla_page_load_details 04:26:09 INFO - PROCESS | 22233 | |i|pagename|runs| 04:26:09 INFO - PROCESS | 22233 | |0;ai-astar;113;113;112;111;112;112;108;113;113;111 04:26:09 INFO - PROCESS | 22233 | |1;audio-beat-detection;153;126;156;179;133;159;154;132;203;127 04:26:09 INFO - PROCESS | 22233 | |2;audio-dft;160;163;161;160;160;161;162;160;159;161 04:26:09 INFO - PROCESS | 22233 | |3;audio-fft;76;76;76;175;76;77;76;75;180;76 04:26:09 INFO - PROCESS | 22233 | |4;audio-oscillator;93;93;154;91;92;92;146;92;92;146 04:26:09 INFO - PROCESS | 22233 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;116;116;116 04:26:09 INFO - PROCESS | 22233 | |6;imaging-darkroom;146;146;147;145;146;145;146;145;145;144 04:26:09 INFO - PROCESS | 22233 | |7;imaging-desaturate;95;95;95;94;94;95;94;94;96;94 04:26:09 INFO - PROCESS | 22233 | |8;json-parse-financial;55;59;55;55;54;54;56;77;53;52 04:26:09 INFO - PROCESS | 22233 | |9;json-stringify-tinderbox;59;57;56;58;58;61;58;57;61;57 04:26:09 INFO - PROCESS | 22233 | |10;stanford-crypto-aes;82;73;74;75;74;78;75;75;74;74 04:26:09 INFO - PROCESS | 22233 | |11;stanford-crypto-ccm;117;117;116;114;115;119;114;110;129;139 04:26:09 INFO - PROCESS | 22233 | |12;stanford-crypto-pbkdf2;156;160;153;165;163;156;158;157;155;163 04:26:09 INFO - PROCESS | 22233 | |13;stanford-crypto-sha256-iterative;68;65;67;64;67;67;67;65;64;64 04:26:09 INFO - PROCESS | 22233 | __end_tp_report 04:26:09 INFO - PROCESS | 22233 | __start_cc_report 04:26:09 INFO - PROCESS | 22233 | _x_x_mozilla_cycle_collect,1616 04:26:09 INFO - PROCESS | 22233 | __end_cc_report 04:26:09 INFO - PROCESS | 22233 | __startTimestamp1462965969589__endTimestamp 04:26:09 INFO - PROCESS | 22233 | 04:26:09 INFO - PROCESS | 22233 | ------- Summary: start ------- 04:26:09 INFO - PROCESS | 22233 | Number of tests: 14 04:26:09 INFO - PROCESS | 22233 | 04:26:09 INFO - PROCESS | 22233 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.50 stddev:1.55 (1.4%) stddev-sans-first:1.58 04:26:09 INFO - PROCESS | 22233 | Values: 113.0 113.0 112.0 111.0 112.0 112.0 108.0 113.0 113.0 111.0 04:26:09 INFO - PROCESS | 22233 | 04:26:09 INFO - PROCESS | 22233 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:155.00 stddev:24.63 (15.9%) stddev-sans-first:26.13 04:26:09 INFO - PROCESS | 22233 | Values: 153.0 126.0 156.0 179.0 133.0 159.0 154.0 132.0 203.0 127.0 04:26:09 INFO - PROCESS | 22233 | 04:26:09 INFO - PROCESS | 22233 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 04:26:09 INFO - PROCESS | 22233 | Values: 160.0 163.0 161.0 160.0 160.0 161.0 162.0 160.0 159.0 161.0 04:26:09 INFO - PROCESS | 22233 | 04:26:09 INFO - PROCESS | 22233 | [#3] audio-fft Cycles:10 Average:96.30 Median:76.00 stddev:42.81 (56.3%) stddev-sans-first:44.78 04:26:09 INFO - PROCESS | 22233 | Values: 76.0 76.0 76.0 175.0 76.0 77.0 76.0 75.0 180.0 76.0 04:26:09 INFO - PROCESS | 22233 | 04:26:09 INFO - PROCESS | 22233 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:92.00 stddev:27.40 (29.8%) stddev-sans-first:28.43 04:26:09 INFO - PROCESS | 22233 | Values: 93.0 93.0 154.0 91.0 92.0 92.0 146.0 92.0 92.0 146.0 04:26:09 INFO - PROCESS | 22233 | 04:26:09 INFO - PROCESS | 22233 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:26:09 INFO - PROCESS | 22233 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 04:26:09 INFO - PROCESS | 22233 | 04:26:09 INFO - PROCESS | 22233 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 04:26:09 INFO - PROCESS | 22233 | Values: 146.0 146.0 147.0 145.0 146.0 145.0 146.0 145.0 145.0 144.0 04:26:09 INFO - PROCESS | 22233 | 04:26:09 INFO - PROCESS | 22233 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 04:26:09 INFO - PROCESS | 22233 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 94.0 94.0 96.0 94.0 04:26:09 INFO - PROCESS | 22233 | 04:26:09 INFO - PROCESS | 22233 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:55.00 stddev:7.27 (13.2%) stddev-sans-first:7.68 04:26:09 INFO - PROCESS | 22233 | Values: 55.0 59.0 55.0 55.0 54.0 54.0 56.0 77.0 53.0 52.0 04:26:09 INFO - PROCESS | 22233 | 04:26:09 INFO - PROCESS | 22233 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:1.69 (2.9%) stddev-sans-first:1.76 04:26:09 INFO - PROCESS | 22233 | Values: 59.0 57.0 56.0 58.0 58.0 61.0 58.0 57.0 61.0 57.0 04:26:09 INFO - PROCESS | 22233 | 04:26:09 INFO - PROCESS | 22233 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:75.00 stddev:2.67 (3.6%) stddev-sans-first:1.41 04:26:09 INFO - PROCESS | 22233 | Values: 82.0 73.0 74.0 75.0 74.0 78.0 75.0 75.0 74.0 74.0 04:26:09 INFO - PROCESS | 22233 | 04:26:09 INFO - PROCESS | 22233 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:117.00 stddev:8.59 (7.3%) stddev-sans-first:9.08 04:26:09 INFO - PROCESS | 22233 | Values: 117.0 117.0 116.0 114.0 115.0 119.0 114.0 110.0 129.0 139.0 04:26:09 INFO - PROCESS | 22233 | 04:26:09 INFO - PROCESS | 22233 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:159.00 stddev:3.98 (2.5%) stddev-sans-first:4.11 04:26:09 INFO - PROCESS | 22233 | Values: 156.0 160.0 153.0 165.0 163.0 156.0 158.0 157.0 155.0 163.0 04:26:09 INFO - PROCESS | 22233 | 04:26:09 INFO - PROCESS | 22233 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:67.00 stddev:1.55 (2.3%) stddev-sans-first:1.42 04:26:09 INFO - PROCESS | 22233 | Values: 68.0 65.0 67.0 64.0 67.0 67.0 67.0 65.0 64.0 64.0 04:26:09 INFO - PROCESS | 22233 | -------- Summary: end -------- 04:26:09 INFO - PROCESS | 22233 | 04:26:10 INFO - TEST-INFO | 22233: exit 0 04:26:10 INFO - TEST-OK | kraken | took 60536ms 04:26:10 INFO - SUITE-END | took 1172s 04:26:10 INFO - Completed test suite (00:19:32) 04:26:10 INFO - javascript benchmark 04:26:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3298.1424829544317, 3340.749443791715, 3361.630220675726, 3373.3927892979254, 3386.2211691311, 5510.972445137773, 5529.91705124423, 5548.556115510754, 5549.1676248562735, 5570.359408668004, 5513.889722205554, 5536.0, 5543.417941116175, 5558.916616250749, 5577.888442231153, 4846.4911184325665, 5110.974445127778, 5134.614903882205, 5184.688918664892, 5214.687118772886, 4874.341963834872, 4890.14422476067, 4940.901181976358, 4943.826966056189, 4945.282933974571, 4899.240617704261, 5066.97466512667, 5134.871628209287, 5168.664036837612, 5186.974065129669, 5104.2088476286235, 5130.51260130287, 5132.640715149941, 5138.794448222104, 5170.508801663836, 4919.0, 4989.126902791997, 5022.196448568248, 5025.045241404122, 5067.721275329855, 5339.145736682112, 5370.033393989081, 5401.351837779492, 5420.34955805302, 5428.077226871442, 5776.422357764232, 5792.855178620568, 5795.82612521625, 5800.158976948319, 5800.9129863052085, 5757.510611598019, 5833.0, 5834.883302333929, 5877.353491115974, 5899.439553242435, 5416.160495123262, 5453.672779633234, 5458.6724796512335, 5461.208124821918, 5462.918056229159, 5804.535637149018, 5959.0763431668165, 5966.254218222723, 5966.731497082642, 5967.283925928829, 5787.681677507693, 5851.561132915049, 5875.588708790429, 5888.293404791367, 5926.61477004002, 5697.173909783059, 5702.971485142548, 5704.0, 5712.514436272881, 5716.456936591017, 5677.233573467529, 5680.11958146488, 5684.204211410406, 5690.6870122142855, 5859.267591551056, 5802.88394232113, 5838.182654428383, 5847.736851841677, 5852.678102704393, 5883.02930016551, 4458.910821783546, 4472.686911916199, 4473.843415480507, 4478.2610869206865, 4506.188886000486, 3971.920561588752, 3984.442178095069, 4003.5996400360314, 4005.599440055971, 4047.2917239483563, 5543.944560554423, 5564.666120032811, 5571.0, 5573.108302671553, 5600.35595906476, 5865.794697185664, 5866.442687944638, 5870.530357571384, 5878.882422351615, 5885.264341957255, 5465.535429488458, 5511.421300763443, 5566.666000040011, 5629.493345598916, 5636.915446268227, 4740.525947405232, 4763.404574428197, 4766.785494652749, 4768.499307572724, 4790.712557246577, 5980.073088671263, 6038.184845045863, 6039.879202416015, 6040.788572399945, 6047.909281360783, 5766.077427611646, 5942.257217847769, 5979.850503737442, 5982.551308651956, 5989.970050149721, 6026.15633811258, 6037.0, 6048.667323297261, 6055.848603784764, 6061.636301821904, 5604.551635869202, 5752.971235143965, 5755.65466072037, 5756.94243057564, 5770.076787713946, 5818.9127163093435, 5853.590248682552, 5866.061430171152, 5867.20792692981, 5901.9966605678, 5661.094224923992, 5667.319921609434, 5671.914921276101, 5694.601377903673, 5697.430256974435, 5516.668999860021, 5651.943480565306, 5656.688882111359, 5666.490015898424, 5759.740811663569, 5595.328560572594, 5615.859603509945, 5626.071698169756, 5628.380878103487, 5665.065264231355, 5734.598578099493, 5775.33583637887, 5791.0, 5796.101604251347, 5798.217240672455, 5487.5609951203005, 5659.688717120598, 5667.263255776723, 5672.461116193955, 5736.512396446182], "value": 5400.813236244221, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.9106929495223, 659.6866488418001, 660.7092879133182, 671.4259308291414, 677.2820809941466, 32352.67647323526, 39588.0, 40526.0, 40544.79727601358, 40580.59419405805, 44052.33921491172, 44536.33195502062, 44549.55450445494, 44551.55448445515, 44622.55377446225, 7814.570198639072, 8593.097724738891, 8702.912970870306, 8753.0, 10163.745906352326, 10497.580096796119, 10596.735081622945, 10602.78794424111, 10608.946955265214, 10620.415877126756, 10835.0, 10919.071878890303, 10927.945360273188, 10928.071113955324, 10930.0, 8023.237792409712, 8212.219839115274, 10248.846267305997, 10398.636047738293, 10771.730706732355, 10399.220058495568, 10517.737056573647, 10528.842067368996, 10531.578736850517, 10532.315399499008, 39569.20861582752, 40212.59787402118, 40314.395284070764, 40330.596694032974, 40387.19225615471, 3755.755875868087, 3769.6607305342377, 3774.6036666149935, 3877.321468742987, 3919.8236079376497, 33592.1601959953, 33979.15052123692, 34168.82915585406, 34243.315133697186, 34622.0, 4534.909301813978, 4664.720116793003, 4676.392069031004, 4697.859064228044, 4725.716457012591, 323225.0, 328347.0, 328483.0, 328915.0, 329340.0, 42319.57680423218, 65343.34656653373, 67056.0, 67146.66426667836, 67151.0, 40790.38814417786, 40911.977200570225, 41075.178496430504, 41293.58706412958, 41338.1732365351, 17838.5540361492, 18118.909405452887, 18135.45593632193, 18143.546411339557, 18150.636987260183, 13571.52499662507, 14795.926020370045, 15227.314770835117, 15249.847501524842, 15300.311485983157, 9421.952890235505, 9466.479343636167, 9478.431294122374, 9515.666951656658, 9526.0, 3582.30145121704, 3622.945655815165, 3629.292288003814, 3710.313591985437, 3719.088823238324, 1095.5562996986234, 1122.5734220996133, 1210.267787988272, 1297.8312819333426, 1316.6701631352403, 32983.0, 33221.0, 33424.0, 33657.0, 33693.15767105793, 1226.399064458427, 1234.9012079033655, 1245.0724210463081, 1307.6469353274754, 1340.8994325425633, 17423.12884355777, 17749.822501775074, 17941.0, 18155.183016764015, 18294.542636434195, 451001.0, 451024.0, 453762.0, 454931.0, 455420.0, 61516.38483615196, 62180.37819621746, 62181.0, 62213.0, 62244.68877655583, 1308.3523655790445, 1534.4706076403622, 1542.0362273579012, 1581.7627355896707, 1629.413411171977, 30171.547426789053, 31286.687133128376, 31582.210444739067, 32157.0, 32514.0, 46189.76905115453, 60941.0, 61747.691261543405, 62249.0, 62423.0, 440423.0, 444921.0, 451427.0, 451452.0, 452378.0, 39671.0, 46434.767826160656, 48005.51994480011, 48032.5196748028, 48511.5148848507, 45260.09479810319, 45541.0, 46356.0, 46674.53325466702, 47670.0, 41295.0, 41363.7931810339, 42465.787671061444, 42822.571774283104, 43521.0, 41963.37054944117, 42130.36804447997, 42774.0, 42820.35769463398, 43118.35322470103, 43075.353869692604, 43706.0, 44175.0, 44294.77852610716, 44691.10617787691, 36081.0, 36950.07624809401, 38224.0, 38533.0, 38535.61464385432, 28758.0, 29178.270543236587, 29217.0, 29221.123366299045, 29378.0], "value": 20364.86040608823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.8812326610182, 435.0667817531397, 438.42566238227914, 447.3602748070259, 452.8098198756522, 18309.633807323862, 19023.52441188971, 19242.422727318168, 20212.0, 20683.65556238847, 19821.306254281102, 20251.797482025177, 20423.18307267711, 20495.07772150253, 20506.384808455732, 5691.658500489973, 5714.828555143353, 5866.501347385477, 5902.468777809996, 5904.645721256717, 4246.893827654302, 5808.506276966463, 5808.535317174637, 6081.817545473643, 6365.58623689461, 6331.335209802974, 6350.777722779703, 6361.6183029018175, 6362.268339140988, 6362.459190968773, 6286.685665716719, 6316.3683631636695, 6328.050792381179, 6374.617522948592, 6414.647194404282, 3942.231264903345, 5531.25328080712, 5776.422357764232, 5785.045467497858, 5802.5938184327115, 22369.217077402212, 22378.104875804947, 22456.663150052762, 22702.54594908109, 23868.40328991772, 2361.6575596538405, 2383.9642405363934, 2431.270618814349, 3159.3997140543224, 3269.5095735639607, 10822.458877056115, 11060.336379817156, 11072.28030178044, 12770.936145319307, 14257.714845703027, 2047.119738512439, 2091.9267825626184, 2111.9788802111934, 2129.818965387944, 2150.860194087379, 82417.58791206006, 83769.16230837675, 83834.58082709547, 84232.99999999939, 85054.0, 11380.772384552263, 11513.424328783527, 11595.478203480863, 11605.0, 11641.0, 16030.438934637232, 16265.430709925096, 16391.0, 16402.917985409997, 16414.0, 8447.619857106445, 8627.40393027292, 8628.654853805903, 8675.436096653824, 8801.823963520821, 8377.6230069647, 8479.491230526188, 8481.363897707697, 8792.42849214799, 8802.07578204292, 4749.786259618326, 4793.065352256276, 4871.658983871095, 4907.582855457326, 5007.9499205008215, 1838.5771272607376, 2021.938482296806, 2122.2466024561368, 3380.645032271625, 3384.7799893006877, 1014.5789497358513, 1114.9777004460027, 1151.9424028798526, 1170.777552265067, 1188.2395267029108, 18346.449606511826, 18704.906475467535, 19006.95461749617, 19051.61896762057, 19708.70436943447, 1024.533837104116, 1082.2045796339685, 1084.9403282819521, 1150.4017910686564, 1156.9363684997406, 10725.51735171919, 10859.83710244347, 10903.0, 10909.454527273605, 10927.562897484171, 543103.0, 543528.0, 553768.0, 574899.0, 578867.0, 88473.11526884777, 92402.0, 93012.0, 93732.53133734288, 94087.0, 1062.3625824505234, 1068.8450174724621, 1092.830611255241, 1094.7974624694457, 1095.2059756676506, 16881.831181688518, 16996.23516941716, 17039.48881533556, 17052.403165889133, 17187.82812171912, 40441.39337909993, 41005.589944100175, 41661.79169104135, 41776.0, 42397.78801105975, 58920.705396472746, 59976.700116500884, 60058.69970650119, 60172.69913650404, 60673.69663151656, 9209.907900921173, 9229.0, 9254.722358329262, 9264.258859291376, 9336.206422454168, 10130.8480372793, 12724.872751272369, 13698.794518082037, 13984.370703318578, 14020.929895350459, 6446.419822216023, 10178.694639160836, 11914.285142891455, 12036.157468977088, 12238.571649992207, 11758.82361764557, 11841.407929603312, 12075.27548347102, 12314.445849936596, 12314.507419703112, 12142.0, 12278.631641050782, 12418.689532761753, 12517.248965062125, 12576.0, 9025.638974440948, 9056.275497960016, 9194.862077068716, 9217.539123043955, 9289.814203715752, 9225.169734723908, 11755.0, 11856.288622682667, 12085.818712719492, 12245.387730613611], "value": 9704.190484047484, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.196510128822, 1545.0343535290444, 1561.898476599021, 1754.789425268968, 1876.8873867567938, 7598.088229412471, 7796.220377962201, 7845.4900431471915, 7847.2152784721575, 7897.052353717548, 7662.885056724153, 7828.217178282169, 7830.765077047683, 7844.607769611525, 7851.960740196305, 2077.45986043629, 2271.659251112338, 2336.0889253191226, 2341.683872677184, 2354.75275096115, 2382.5592265430864, 2390.175389490623, 2390.2351247600773, 2393.5930891748444, 2395.2215529952746, 2302.343832007878, 2354.0, 2358.151065616377, 2358.516504116652, 2362.787349138577, 2045.9897700511476, 2232.910683572655, 2270.625346817773, 2278.943026424336, 2279.190887235041, 2275.5448910217856, 2275.8179345652306, 2296.379977406091, 2301.9309420717404, 2350.518143780538, 7751.30238278552, 7751.418643601696, 7799.688012479494, 7806.960965195138, 7808.945792318021, 4894.2903279024695, 5037.647364684473, 5043.193089105725, 5045.217991211368, 5084.313617661605, 3365.4110530657035, 3366.7979921204806, 3387.5426817379584, 3430.0395889150827, 3443.9483407748903, 1261.400834603556, 1275.489804078367, 1278.207511342964, 1280.3086333379963, 1346.764316244663, 10834.837477437844, 10842.186835987333, 10848.78302433947, 10849.67450976472, 10878.72803179919, 4195.811188496525, 4329.956700433018, 4348.934765978513, 4397.978010109929, 4405.867823965286, 9327.673531426368, 9425.717228483156, 9428.15146636806, 9431.764205894908, 9442.15020648145, 4542.863714088583, 4981.9252711209365, 4982.526659967298, 4982.551570358685, 4983.626228032912, 4615.699979501322, 4618.468876079294, 4637.768111594407, 4680.4149481314835, 4705.64707646921, 3910.6284902934176, 3980.7810570418324, 4025.1081991463966, 4048.109415928491, 4091.468109145792, 1291.1607455154226, 1304.8368953880765, 1313.3761463305045, 1316.5128902306017, 1321.14125818217, 1070.4112737994071, 1075.295681328731, 1077.4074259157433, 1082.5723839083676, 1086.3970496374588, 5702.942970570324, 5775.162601422854, 5862.208601838697, 5911.172435858897, 5911.733971971272, 478.54299144317787, 497.9004199160182, 500.96493245472465, 501.2331133365883, 505.2547492448682, 3817.599152089046, 3987.5813039631003, 4007.539132999684, 4055.1889622075114, 4061.147159096623, 9840.507974601242, 10157.288989770794, 10317.742056448498, 10323.0, 10331.070203681706, 9923.0, 9992.500374981222, 10076.29465937392, 10162.542685579167, 10176.440295783803, 7934.841303173905, 7960.283574478209, 8037.7588672339925, 8048.798780030546, 8049.436539442183, 5782.2194003808945, 5888.823335299948, 5910.911336330045, 5926.348101708722, 6046.5767396281835, 9072.95463522678, 9154.908450915405, 9164.6792362267, 9273.67542136022, 9317.6272949084, 9125.726228213165, 9290.0, 9297.488638124698, 9488.478133702436, 9511.57197926081, 6525.608463492205, 7055.082839231072, 7246.275372462712, 7501.88747168782, 7570.9242907570215, 7955.960220198862, 7992.6802927884555, 8001.8399632008195, 8049.476784009021, 8059.597020148852, 7123.7862864112085, 7126.893096603659, 7129.857402851811, 7234.710611575478, 7512.962435187789, 7267.709291628275, 7286.890696639449, 7305.545754086233, 7320.8535829282055, 7365.226651201547, 6712.4294434971625, 6727.73089076451, 6756.4257038150345, 6761.661916904037, 6778.2543920167755, 5127.564157046693, 5239.748372540181, 5249.160134378634, 5323.228131920772, 5335.466453354788, 5358.598105142052, 5371.785128594813, 5383.2463455117095, 5405.0, 5441.075017246998], "value": 4422.599564429422, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.66076584181656, 344.5279966445968, 353.2951761236334, 365.4718931144497, 372.0661140537251, 6319.0, 6378.681065946702, 6384.904226436607, 6410.647414392207, 6414.358564143595, 6311.621302721828, 6312.6212427254395, 6330.8100756977365, 6332.461740752042, 6334.0, 4601.148787474328, 4716.575508204261, 4797.40032495938, 4812.254100614393, 4816.686915350491, 4834.879128021792, 4838.701616732042, 4869.586085182746, 4877.414710234777, 4878.70727756334, 4637.930431043537, 4827.58965487934, 4836.879078023042, 4837.709737415748, 4849.0301939612045, 4699.7415142167165, 4839.128956787777, 4842.15262329091, 4843.685160464576, 4849.272609108627, 4254.446921900133, 4257.340112282601, 4257.872263832059, 4268.679849011305, 4273.9358909616385, 6041.667708276043, 6054.666993315366, 6056.6063205891915, 6058.030715085565, 6062.393465731585, 5638.74625641843, 5638.943610563882, 5647.8588035299035, 5649.887002259973, 5653.604247702662, 6394.200724909387, 6608.504362172808, 6611.669416529202, 6614.107095542088, 6619.702113404908, 4566.337881007268, 4599.540045995407, 4601.585857272828, 4603.49361570227, 4604.963883126304, 6910.965445172792, 6985.615791131486, 6991.475639327122, 6994.790156295319, 6996.440284777205, 4704.1062198182235, 4712.481627021025, 4718.8584342469785, 4720.504347043579, 4720.740359280273, 4779.904401911942, 4782.95217047832, 4790.353302304145, 4790.377250957354, 4793.976030119827, 5534.86162845924, 5538.418466061086, 5544.833654990357, 5555.361133469622, 5559.77760889568, 6490.0, 6719.563228390237, 6732.528722989344, 6736.494762892803, 6742.325767423316, 1644.071099828593, 1675.246139237348, 1678.8321167883357, 1681.1762236504026, 1682.528891910267, 1027.4554486122368, 1068.5245065945735, 1087.3693257910393, 1097.8133717268083, 1099.7745462180235, 6184.484801223729, 6363.96818015907, 6377.553571249968, 6383.521235907326, 6383.585066970632, 6787.185537735503, 6847.21257055435, 6852.554583952126, 6857.7256909723055, 6869.347411995853, 6375.71309291083, 6380.042993550912, 6383.265924418658, 6386.616802991743, 6387.744490220432, 3629.8366573504254, 3663.2124093320062, 3664.193877346979, 3667.74325797197, 3668.816559172084, 6897.517173797786, 7038.049863268496, 7048.118985126859, 7058.435325173974, 7065.894011589728, 6875.1749790025515, 6880.65596720162, 6886.552374095668, 6891.345322194384, 6892.0, 7018.298170183043, 7021.473389495808, 7023.508354415244, 7024.754133605299, 7031.613261270679, 6752.223494298219, 6756.729730810713, 6760.459163267025, 6764.222114456704, 6764.323567643196, 6529.7388104475285, 6654.268030516736, 6671.733130674718, 6679.833004174934, 6699.665016749241, 6991.580505169706, 6997.405220556309, 7014.579969910373, 7019.403350715246, 7027.789166325018, 4670.042641258466, 4671.672982891165, 4673.579377856009, 4674.439067311944, 4675.345451636842, 6723.966380168264, 6729.057931889637, 6734.3602357775935, 6735.191776986793, 6737.023131645982, 6386.137871387489, 6555.049517819794, 6558.868822623616, 6654.268030516542, 6658.63377514222, 6485.967570162119, 6514.54398192122, 6518.674066296761, 6529.216494020748, 6533.052707357501, 6396.6481843497195, 6404.4876409886165, 6407.935920640734, 6414.839629009312, 6424.100625912282, 6540.901886471612, 6542.247641521286, 6554.573952693059, 6559.6064236144075, 6560.573562718408, 6240.812775616739, 6417.903731444126, 6419.6790160490855, 6420.7431702731365, 6432.839179020375], "value": 4993.260366318215, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.5283088639475, 838.5597561280331, 854.1842540373948, 907.8910530736313, 927.9721608351749, 15481.612959676, 15742.134182619951, 15826.28781704823, 15862.920685396557, 15873.603159921007, 14471.710565788679, 14558.854411455883, 14577.416903323881, 14581.416743330254, 14590.635234119152, 739.4343327354578, 879.2350654930219, 883.6288758721337, 897.6185121323444, 904.4889637354906, 887.7381172554079, 889.1908363389317, 891.2068259249273, 891.8216356728681, 891.9063498332679, 949.6011675096441, 950.9001554836747, 951.7620594851287, 951.9619215231417, 953.1516949914582, 772.0696560644438, 934.0, 944.4805357053627, 948.6395169835488, 948.9952550237274, 697.3967518096861, 697.7243988624465, 698.333091897242, 698.6192525073847, 699.6606645776794, 15046.849531504764, 15056.774148387783, 15116.924415377853, 15127.470538531208, 15133.167675777828, 14963.625909352353, 15790.289436975363, 15805.367785288574, 15815.209239537977, 15886.841131588651, 12073.517059317617, 12155.696107597292, 12189.746523718386, 12212.450439730233, 12359.567415140427, 4038.192361527677, 4040.676745860324, 4101.958980410188, 4123.793810309473, 4180.122174343392, 54884.17673734897, 55502.05742799023, 55526.44473555253, 55729.72135139298, 58312.70843645755, 11265.605703800327, 11431.428428578538, 11541.422928853524, 12029.518819247307, 12084.697882552831, 19815.801841981684, 20695.27566535164, 20946.685799713017, 20961.79038209629, 21008.159673612885, 9012.361691725875, 9025.187733104052, 9063.048379920145, 9128.634854605742, 9331.300152488455, 5127.0, 5132.204508301219, 5153.484651534816, 5192.1173400522, 5209.7916083356995, 3460.8788692395647, 3517.771344862576, 3518.5425894633536, 3524.6299138590593, 3529.1000794797164, 554.2157846647029, 619.5229673151738, 652.2271108736163, 659.9736010559524, 660.2736989311719, 697.6825544377297, 705.8905869590221, 716.9677364518609, 741.2624438683545, 785.5561607691636, 9822.214222862154, 10022.799544009078, 10123.240756943258, 10166.390016599027, 10239.641612543524, 696.095076400677, 740.4964624055693, 761.702935855017, 789.455275859655, 815.7185770909027, 4463.687541872103, 4593.908121837545, 4683.484816670163, 4702.130105930414, 4720.291956206528, 65237.347626524075, 65914.34085659178, 66492.0, 66682.0, 66785.0, 58017.419825801204, 58158.418415816144, 59690.0, 60109.0, 60325.69837150786, 51838.740806295726, 51974.740126299126, 52139.47860521346, 52787.472125278255, 53174.468255317726, 9122.635094596142, 9129.726108216764, 9162.404443711137, 9245.953770231376, 9439.38643988166, 39427.80286098551, 39604.80197598993, 40064.59935400609, 40382.596174039056, 41137.38293925534, 47082.529174707815, 49418.0, 50935.49064509307, 51108.0, 52139.73930130325, 10963.397013164353, 11707.0, 11945.402729863647, 13002.089853710528, 13158.934205328913, 13082.28047457399, 14095.859041409454, 14537.127772333693, 14553.92723036378, 14936.925315373353, 13062.804057938949, 13894.791578126134, 14057.437702491785, 14235.857641423867, 14788.482403115839, 12447.39140792501, 12881.549145779853, 13289.0, 13449.327533623475, 13687.931560342135, 13594.45622175102, 13633.795493067413, 13851.16892986424, 13912.165270083828, 14129.858701412853, 11482.0, 11532.0, 11659.76680466369, 11734.178607497393, 11879.703007424538, 11025.415601023107, 11033.613823516138, 11050.613228536962, 11156.330620162817, 11505.597304094317], "value": 7236.441176158268, "unit": "score"}], "name": "dromaeo_css", "value": 7447.1155224198155, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 112.0, 111.0, 112.0, 112.0, 108.0, 113.0, 113.0, 111.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 156.0, 179.0, 133.0, 159.0, 154.0, 132.0, 203.0, 127.0], "value": 152.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 161.0, 160.0, 160.0, 161.0, 162.0, 160.0, 159.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 175.0, 76.0, 77.0, 76.0, 75.0, 180.0, 76.0], "value": 96.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 154.0, 91.0, 92.0, 92.0, 146.0, 92.0, 92.0, 146.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 144.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 96.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 55.0, 55.0, 54.0, 54.0, 56.0, 77.0, 53.0, 52.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 56.0, 58.0, 58.0, 61.0, 58.0, 57.0, 61.0, 57.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 73.0, 74.0, 75.0, 74.0, 78.0, 75.0, 75.0, 74.0, 74.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 114.0, 115.0, 119.0, 114.0, 110.0, 129.0, 139.0], "value": 119.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 160.0, 153.0, 165.0, 163.0, 156.0, 158.0, 157.0, 155.0, 163.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 67.0, 64.0, 67.0, 67.0, 67.0, 65.0, 64.0, 64.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1520.7, "alertThreshold": 2.0}]} 04:26:10 INFO - Return code: 0 04:26:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:26:10 ERROR - # TBPL SUCCESS # 04:26:10 INFO - Running post-action listener: _resource_record_post_action 04:26:10 INFO - Running post-run listener: _resource_record_post_run 04:26:11 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 262144; Write bytes: 496660480; Read time: 16; Write time: 482976 04:26:11 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248782848; Read time: 0; Write time: 294800 04:26:12 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 247877632; Read time: 16; Write time: 188176 04:26:12 INFO - Running post-run listener: _upload_blobber_files 04:26:12 INFO - Blob upload gear active. 04:26:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:26:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:26:12 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'] 04:26:12 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 04:26:12 INFO - (blobuploader) - INFO - Open directory for files ... 04:26:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:26:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:26:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:13 INFO - (blobuploader) - INFO - Done attempting. 04:26:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:26:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:26:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:13 INFO - (blobuploader) - INFO - Done attempting. 04:26:13 INFO - (blobuploader) - INFO - Iteration through files over. 04:26:13 INFO - Return code: 0 04:26:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:26:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:26:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5532c69b6056f5c83493e58d57e757e23bedce8f17257e195602624ed9a0d591e91633a32c1ca6983734ed56260bee28d386139734283da7e61fc0d56c5fdcc7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cabe5eabdd4a20c454c0a4116b249177abbb18c6ee8d4d5be2bc88ab559cac38a441939ceb11849a23aa7df2cd331e2bda08a4995fecd03467b8fee3254eee58"} 04:26:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:26:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:26:13 INFO - Contents: 04:26:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5532c69b6056f5c83493e58d57e757e23bedce8f17257e195602624ed9a0d591e91633a32c1ca6983734ed56260bee28d386139734283da7e61fc0d56c5fdcc7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cabe5eabdd4a20c454c0a4116b249177abbb18c6ee8d4d5be2bc88ab559cac38a441939ceb11849a23aa7df2cd331e2bda08a4995fecd03467b8fee3254eee58"} 04:26:13 INFO - Running post-run listener: copy_logs_to_upload_dir 04:26:13 INFO - Copying logs to upload dir... 04:26:13 INFO - mkdir: /builds/slave/test/build/upload/logs 04:26:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.219383 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-11 04:26:13.812910) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 04:26:13.816974) ========= 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=eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5532c69b6056f5c83493e58d57e757e23bedce8f17257e195602624ed9a0d591e91633a32c1ca6983734ed56260bee28d386139734283da7e61fc0d56c5fdcc7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cabe5eabdd4a20c454c0a4116b249177abbb18c6ee8d4d5be2bc88ab559cac38a441939ceb11849a23aa7df2cd331e2bda08a4995fecd03467b8fee3254eee58"} build_url:https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5532c69b6056f5c83493e58d57e757e23bedce8f17257e195602624ed9a0d591e91633a32c1ca6983734ed56260bee28d386139734283da7e61fc0d56c5fdcc7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cabe5eabdd4a20c454c0a4116b249177abbb18c6ee8d4d5be2bc88ab559cac38a441939ceb11849a23aa7df2cd331e2bda08a4995fecd03467b8fee3254eee58"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 04:26:13.845071) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:26:13.845865) ========= 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=eca2ab57546de7b41f256b19000001ef-1462964697.222762-1878770524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004408 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:26:13.930227) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 04:26:13.930837) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 04:26:13.931337) ========= ========= Total master_lag: 0.19 =========