builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1462964640.01 results: success (0) buildid: 20160510142413 builduid: 93e058acf8334e7aae447a8479c457fb revision: 1dd42a351054c5b697873d647169019d4d77d762 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 04:04:00.006696) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 04:04:00.007145) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 04:04:00.007422) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 04:04:00.024142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:04:00.024649) ========= 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=af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 04:04:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-05-11 04:04:00 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073649 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:04:00.112336) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:04:00.112651) ========= 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=af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018246 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:04:00.162658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:04:00.163030) ========= 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=af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 04:04:00,494 truncating revision to first 12 chars 2016-05-11 04:04:00,494 Setting DEBUG logging. 2016-05-11 04:04:00,494 attempt 1/10 2016-05-11 04:04:00,494 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:04:00,785 unpacking tar archive at: mozilla-aurora-1dd42a351054/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584684 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:04:00.760471) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 04:04:00.760823) ========= script_repo_revision: 1dd42a351054c5b697873d647169019d4d77d762 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 04:04:00.761202) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 04:04:00.761518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 04:04:00.770714) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-11 04:04:00.771031) ========= /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=af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:04:01 INFO - MultiFileLogger online at 20160511 04:04:01 in /builds/slave/test 04:04:01 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:04:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:04:01 INFO - {'append_to_log': False, 04:04:01 INFO - 'base_work_dir': '/builds/slave/test', 04:04:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:04:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:04:01 INFO - 'branch': 'Mozilla-Aurora', 04:04:01 INFO - 'buildbot_json_path': 'buildprops.json', 04:04:01 INFO - 'config_files': ('talos/linux_config.py',), 04:04:01 INFO - 'default_actions': ('clobber', 04:04:01 INFO - 'read-buildbot-config', 04:04:01 INFO - 'download-and-extract', 04:04:01 INFO - 'populate-webroot', 04:04:01 INFO - 'create-virtualenv', 04:04:01 INFO - 'install', 04:04:01 INFO - 'run-tests'), 04:04:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:04:01 INFO - 'download_minidump_stackwalk': True, 04:04:01 INFO - 'download_symbols': 'ondemand', 04:04:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:04:01 INFO - 'tooltool.py': '/tools/tooltool.py', 04:04:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:04:01 INFO - '/tools/misc-python/virtualenv.py')}, 04:04:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:04:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:04:01 INFO - 'installer_path': 'installer.exe', 04:04:01 INFO - 'log_level': 'info', 04:04:01 INFO - 'log_name': 'talos', 04:04:01 INFO - 'log_to_console': True, 04:04:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:04:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:04:01 INFO - 'opt_config_files': (), 04:04:01 INFO - 'pip_index': False, 04:04:01 INFO - 'sps_profile': False, 04:04:01 INFO - 'sps_profile_interval': 0, 04:04:01 INFO - 'suite': 'dromaeojs', 04:04:01 INFO - 'system_bits': '32', 04:04:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:04:01 INFO - 'title': 'talos-linux64-ix-020', 04:04:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:04:01 INFO - 'use_talos_json': True, 04:04:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:04:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:04:01 INFO - 'work_dir': 'build'} 04:04:01 INFO - ##### 04:04:01 INFO - ##### Running clobber step. 04:04:01 INFO - ##### 04:04:01 INFO - Running pre-action listener: _resource_record_pre_action 04:04:01 INFO - Running main action method: clobber 04:04:01 INFO - rmtree: /builds/slave/test/build 04:04:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:04:01 INFO - Running post-action listener: _resource_record_post_action 04:04:01 INFO - ##### 04:04:01 INFO - ##### Running read-buildbot-config step. 04:04:01 INFO - ##### 04:04:01 INFO - Running pre-action listener: _resource_record_pre_action 04:04:01 INFO - Running main action method: read_buildbot_config 04:04:01 INFO - Using buildbot properties: 04:04:01 INFO - { 04:04:01 INFO - "project": "", 04:04:01 INFO - "product": "firefox", 04:04:01 INFO - "script_repo_revision": "production", 04:04:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:04:01 INFO - "repository": "", 04:04:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:04:01 INFO - "buildid": "20160510142413", 04:04:01 INFO - "pgo_build": "True", 04:04:01 INFO - "basedir": "/builds/slave/test", 04:04:01 INFO - "buildnumber": 497, 04:04:01 INFO - "slavename": "talos-linux64-ix-020", 04:04:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:04:01 INFO - "platform": "ubuntu64_hw", 04:04:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:04:01 INFO - "branch": "mozilla-aurora", 04:04:01 INFO - "repo_path": "releases/mozilla-aurora", 04:04:01 INFO - "revision": "1dd42a351054c5b697873d647169019d4d77d762", 04:04:01 INFO - "stage_platform": "linux64-pgo", 04:04:01 INFO - "builduid": "93e058acf8334e7aae447a8479c457fb", 04:04:01 INFO - "slavebuilddir": "test" 04:04:01 INFO - } 04:04:01 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:04:01 INFO - Running post-action listener: _resource_record_post_action 04:04:01 INFO - ##### 04:04:01 INFO - ##### Running download-and-extract step. 04:04:01 INFO - ##### 04:04:01 INFO - Running pre-action listener: _resource_record_pre_action 04:04:01 INFO - Running main action method: download_and_extract 04:04:01 INFO - mkdir: /builds/slave/test/build/tests 04:04:01 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:04:01 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:04:01 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:04:01 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:04:01 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:04:01 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:04:02 INFO - Downloaded 1361 bytes. 04:04:02 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:04:02 INFO - Using the following test package requirements: 04:04:02 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:04:02 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:02 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:04:02 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:02 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:04:02 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:02 INFO - u'jsshell-linux-x86_64.zip'], 04:04:02 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:02 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:04:02 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:04:02 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:02 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:04:02 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:02 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:04:02 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:02 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:04:02 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:04:02 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:04:02 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:04: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:04:02 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:04:02 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:04:02 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:04:02 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:04:02 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:04:05 INFO - Downloaded 23800226 bytes. 04:04:05 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:04:05 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:04:07 INFO - Return code: 0 04:04:07 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:04: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:04:07 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:04:07 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:04:07 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:04:07 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:04:07 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:04:08 INFO - Downloaded 23800226 bytes. 04:04:08 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:04:08 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:04:09 INFO - Return code: 0 04:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:09 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:04:09 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:04:09 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:04:09 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:04:09 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:04:10 INFO - Downloaded 10840145 bytes. 04:04:10 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:04:10 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:04:10 INFO - Return code: 0 04:04:10 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:04:10 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:04:10 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:04:10 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:04:10 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:04:10 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:04:12 INFO - Downloaded 62686755 bytes. 04:04:12 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:04:12 INFO - mkdir: /builds/slave/test/properties 04:04:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:04:12 INFO - Writing to file /builds/slave/test/properties/build_url 04:04:12 INFO - Contents: 04:04:12 INFO - build_url:https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:04:13 INFO - Running post-action listener: _resource_record_post_action 04:04:13 INFO - Running post-action listener: set_extra_try_arguments 04:04:13 INFO - ##### 04:04:13 INFO - ##### Running populate-webroot step. 04:04:13 INFO - ##### 04:04:13 INFO - Running pre-action listener: _resource_record_pre_action 04:04:13 INFO - Running main action method: populate_webroot 04:04:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:04:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:04:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:04:13 INFO - '--tppagecycles', 04:04:13 INFO - '7'], 04:04:13 INFO - 'tests': ['tsvgm']}}, 04:04:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:04:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:04:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:04:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:04:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:04:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:04:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:13 INFO - 'talos_options': ['--disable-e10s'], 04:04:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:04:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:04:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:13 INFO - 'talos_options': ['--disable-e10s'], 04:04:13 INFO - 'tests': ['damp', 'tps']}, 04:04:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:13 INFO - 'tests': ['damp', 'tps']}, 04:04:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:04:13 INFO - 'tests': ['dromaeo_dom']}, 04:04:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:04:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:04:13 INFO - 'tests': ['a11yr', 04:04:13 INFO - 'ts_paint', 04:04:13 INFO - 'tpaint', 04:04:13 INFO - 'sessionrestore', 04:04:13 INFO - 'sessionrestore_no_auto_restore', 04:04:13 INFO - 'tabpaint']}, 04:04:13 INFO - 'other-e10s': {'tests': ['a11yr', 04:04:13 INFO - 'ts_paint', 04:04:13 INFO - 'tpaint', 04:04:13 INFO - 'sessionrestore', 04:04:13 INFO - 'sessionrestore_no_auto_restore', 04:04:13 INFO - 'tabpaint']}, 04:04:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:04:13 INFO - 'ts_paint', 04:04:13 INFO - 'tpaint', 04:04:13 INFO - 'sessionrestore', 04:04:13 INFO - 'sessionrestore_no_auto_restore', 04:04:13 INFO - 'tabpaint']}, 04:04:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:04:13 INFO - 'ts_paint', 04:04:13 INFO - 'tpaint', 04:04:13 INFO - 'sessionrestore', 04:04:13 INFO - 'sessionrestore_no_auto_restore', 04:04:13 INFO - 'tabpaint']}, 04:04:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:04:13 INFO - 'tests': ['a11yr', 04:04:13 INFO - 'ts_paint', 04:04:13 INFO - 'tpaint', 04:04:13 INFO - 'sessionrestore', 04:04:13 INFO - 'sessionrestore_no_auto_restore', 04:04:13 INFO - 'tabpaint']}, 04:04:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:04:13 INFO - 'tests': ['a11yr', 04:04:13 INFO - 'ts_paint', 04:04:13 INFO - 'tpaint', 04:04:13 INFO - 'sessionrestore', 04:04:13 INFO - 'sessionrestore_no_auto_restore', 04:04:13 INFO - 'tabpaint']}, 04:04:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:04:13 INFO - 'tests': ['tsvgx', 04:04:13 INFO - 'tsvgr_opacity', 04:04:13 INFO - 'tart', 04:04:13 INFO - 'tscrollx', 04:04:13 INFO - 'cart']}, 04:04:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:04:13 INFO - 'tsvgr_opacity', 04:04:13 INFO - 'tart', 04:04:13 INFO - 'tscrollx', 04:04:13 INFO - 'cart']}, 04:04:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:13 INFO - 'talos_options': ['--disable-e10s'], 04:04:13 INFO - 'tests': ['tp5o']}, 04:04:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:13 INFO - 'tests': ['tp5o']}, 04:04:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:13 INFO - 'talos_options': ['--disable-e10s', 04:04:13 INFO - '--xperf_path', 04:04:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:04:13 INFO - 'tests': ['tp5n']}, 04:04:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:13 INFO - 'talos_options': ['--xperf_path', 04:04:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:04:13 INFO - 'tests': ['tp5n']}}, 04:04:13 INFO - 'talos.zip': {'path': '', 04:04:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:04:13 INFO - Running post-action listener: _resource_record_post_action 04:04:13 INFO - ##### 04:04:13 INFO - ##### Running create-virtualenv step. 04:04:13 INFO - ##### 04:04:13 INFO - Running pre-action listener: _resource_record_pre_action 04:04:13 INFO - Running main action method: create_virtualenv 04:04:13 INFO - Creating virtualenv /builds/slave/test/build/venv 04:04:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:04:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:04:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:04:13 INFO - Using real prefix '/usr' 04:04:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:04:13 INFO - Installing distribute.............................................................................................................................................................................................done. 04:04:15 INFO - Installing pip.................done. 04:04:15 INFO - Return code: 0 04:04:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:04: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:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04: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:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0e0e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', '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:04:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:04:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:04:15 INFO - Using env: {'DISPLAY': ':0', 04:04:15 INFO - 'HOME': '/home/cltbld', 04:04:15 INFO - 'LANG': 'en_US.UTF-8', 04:04:15 INFO - 'LANGUAGE': 'en_US:en', 04:04:15 INFO - 'LOGNAME': 'cltbld', 04:04:15 INFO - 'MAIL': '/var/mail/cltbld', 04:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:15 INFO - 'MOZ_NO_REMOTE': '1', 04:04:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:15 INFO - 'NO_EM_RESTART': '1', 04:04:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:15 INFO - 'PWD': '/builds/slave/test', 04:04:15 INFO - 'SHELL': '/bin/bash', 04:04:15 INFO - 'SHLVL': '1', 04:04:15 INFO - 'TERM': 'linux', 04:04:15 INFO - 'TMOUT': '86400', 04:04:15 INFO - 'USER': 'cltbld', 04:04:15 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', 04:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:15 INFO - '_': '/tools/buildbot/bin/python'} 04:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:16 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:04:16 INFO - Cleaning up... 04:04:16 INFO - Return code: 0 04:04:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:16 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 0x7fbe0e0e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', '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:04:16 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:04:16 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:04:16 INFO - Using env: {'DISPLAY': ':0', 04:04:16 INFO - 'HOME': '/home/cltbld', 04:04:16 INFO - 'LANG': 'en_US.UTF-8', 04:04:16 INFO - 'LANGUAGE': 'en_US:en', 04:04:16 INFO - 'LOGNAME': 'cltbld', 04:04:16 INFO - 'MAIL': '/var/mail/cltbld', 04:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:16 INFO - 'MOZ_NO_REMOTE': '1', 04:04:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:16 INFO - 'NO_EM_RESTART': '1', 04:04:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:16 INFO - 'PWD': '/builds/slave/test', 04:04:16 INFO - 'SHELL': '/bin/bash', 04:04:16 INFO - 'SHLVL': '1', 04:04:16 INFO - 'TERM': 'linux', 04:04:16 INFO - 'TMOUT': '86400', 04:04:16 INFO - 'USER': 'cltbld', 04:04:16 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', 04:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:16 INFO - '_': '/tools/buildbot/bin/python'} 04:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:16 INFO - Downloading/unpacking psutil>=0.7.1 04:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:04:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:04:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:04:18 INFO - Installing collected packages: psutil 04:04:18 INFO - Running setup.py install for psutil 04:04:18 INFO - building 'psutil._psutil_linux' extension 04:04:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:04:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:04:18 INFO - building 'psutil._psutil_posix' extension 04:04:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:04:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:04:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:04:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:04:18 INFO - Successfully installed psutil 04:04:18 INFO - Cleaning up... 04:04:18 INFO - Return code: 0 04:04:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0e0e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', '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:04:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:04:18 INFO - Using env: {'DISPLAY': ':0', 04:04:18 INFO - 'HOME': '/home/cltbld', 04:04:18 INFO - 'LANG': 'en_US.UTF-8', 04:04:18 INFO - 'LANGUAGE': 'en_US:en', 04:04:18 INFO - 'LOGNAME': 'cltbld', 04:04:18 INFO - 'MAIL': '/var/mail/cltbld', 04:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:18 INFO - 'MOZ_NO_REMOTE': '1', 04:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:18 INFO - 'NO_EM_RESTART': '1', 04:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:18 INFO - 'PWD': '/builds/slave/test', 04:04:18 INFO - 'SHELL': '/bin/bash', 04:04:18 INFO - 'SHLVL': '1', 04:04:18 INFO - 'TERM': 'linux', 04:04:18 INFO - 'TMOUT': '86400', 04:04:18 INFO - 'USER': 'cltbld', 04:04:18 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', 04:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:18 INFO - '_': '/tools/buildbot/bin/python'} 04:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:04:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:04:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:04:20 INFO - Installing collected packages: mozsystemmonitor 04:04:20 INFO - Running setup.py install for mozsystemmonitor 04:04:20 INFO - Successfully installed mozsystemmonitor 04:04:20 INFO - Cleaning up... 04:04:21 INFO - Return code: 0 04:04:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:04:21 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:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:21 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:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:21 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 0x7fbe0e0e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', '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:04:21 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:04:21 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:04:21 INFO - Using env: {'DISPLAY': ':0', 04:04:21 INFO - 'HOME': '/home/cltbld', 04:04:21 INFO - 'LANG': 'en_US.UTF-8', 04:04:21 INFO - 'LANGUAGE': 'en_US:en', 04:04:21 INFO - 'LOGNAME': 'cltbld', 04:04:21 INFO - 'MAIL': '/var/mail/cltbld', 04:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:21 INFO - 'MOZ_NO_REMOTE': '1', 04:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:21 INFO - 'NO_EM_RESTART': '1', 04:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:21 INFO - 'PWD': '/builds/slave/test', 04:04:21 INFO - 'SHELL': '/bin/bash', 04:04:21 INFO - 'SHLVL': '1', 04:04:21 INFO - 'TERM': 'linux', 04:04:21 INFO - 'TMOUT': '86400', 04:04:21 INFO - 'USER': 'cltbld', 04:04:21 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', 04:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:21 INFO - '_': '/tools/buildbot/bin/python'} 04:04:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:21 INFO - Downloading/unpacking blobuploader==1.2.4 04:04:21 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:04:21 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:04:21 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:04:21 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:04:21 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:04:21 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:04:23 INFO - Downloading blobuploader-1.2.4.tar.gz 04:04:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:04:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:04:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:23 INFO - Downloading docopt-0.6.1.tar.gz 04:04:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:04:23 INFO - Installing collected packages: blobuploader, requests, docopt 04:04:23 INFO - Running setup.py install for blobuploader 04:04:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:04:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:04:23 INFO - Running setup.py install for requests 04:04:24 INFO - Running setup.py install for docopt 04:04:24 INFO - Successfully installed blobuploader requests docopt 04:04:24 INFO - Cleaning up... 04:04:24 INFO - Return code: 0 04:04:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0e0e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', '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:04:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:04:24 INFO - Using env: {'DISPLAY': ':0', 04:04:24 INFO - 'HOME': '/home/cltbld', 04:04:24 INFO - 'LANG': 'en_US.UTF-8', 04:04:24 INFO - 'LANGUAGE': 'en_US:en', 04:04:24 INFO - 'LOGNAME': 'cltbld', 04:04:24 INFO - 'MAIL': '/var/mail/cltbld', 04:04:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:24 INFO - 'MOZ_NO_REMOTE': '1', 04:04:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:24 INFO - 'NO_EM_RESTART': '1', 04:04:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:24 INFO - 'PWD': '/builds/slave/test', 04:04:24 INFO - 'SHELL': '/bin/bash', 04:04:24 INFO - 'SHLVL': '1', 04:04:24 INFO - 'TERM': 'linux', 04:04:24 INFO - 'TMOUT': '86400', 04:04:24 INFO - 'USER': 'cltbld', 04:04:24 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', 04:04:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:24 INFO - '_': '/tools/buildbot/bin/python'} 04:04:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:04:24 INFO - Running setup.py (path:/tmp/pip-Ie8rld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:04:24 INFO - Running setup.py (path:/tmp/pip-Oc8ccJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:04:24 INFO - Running setup.py (path:/tmp/pip-dC7CLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:04:24 INFO - Running setup.py (path:/tmp/pip-mkGGVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:04:24 INFO - Running setup.py (path:/tmp/pip-bDhbO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:04:25 INFO - Running setup.py (path:/tmp/pip-q8y56M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:04:25 INFO - Running setup.py (path:/tmp/pip-VKuwIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:04:25 INFO - Running setup.py (path:/tmp/pip-pRx8PD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:04:25 INFO - Running setup.py (path:/tmp/pip-OI6I2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:04:25 INFO - Running setup.py (path:/tmp/pip-dmUZx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:04:25 INFO - Running setup.py (path:/tmp/pip-jgJIfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:04:25 INFO - Running setup.py (path:/tmp/pip-XWSF8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:04:25 INFO - Running setup.py (path:/tmp/pip-kJ5j1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:04:25 INFO - Running setup.py (path:/tmp/pip-GbwwXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:25 INFO - Running setup.py (path:/tmp/pip-bGQh6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:04:25 INFO - Running setup.py (path:/tmp/pip-QIstVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:04:25 INFO - Running setup.py (path:/tmp/pip-HGsJKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:04:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:04:25 INFO - Running setup.py install for manifestparser 04:04:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:04:25 INFO - Running setup.py install for mozcrash 04:04:26 INFO - Running setup.py install for mozdebug 04:04:26 INFO - Running setup.py install for mozdevice 04:04:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:04:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:04:26 INFO - Running setup.py install for mozfile 04:04:26 INFO - Running setup.py install for mozhttpd 04:04:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:04:26 INFO - Running setup.py install for mozinfo 04:04:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:04:26 INFO - Running setup.py install for mozInstall 04:04:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:04:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:04:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:04:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:04:26 INFO - Running setup.py install for mozleak 04:04:26 INFO - Running setup.py install for mozlog 04:04:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:04:26 INFO - Running setup.py install for moznetwork 04:04:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:04:27 INFO - Running setup.py install for mozprocess 04:04:27 INFO - Running setup.py install for mozprofile 04:04:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:04:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:04:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:04:27 INFO - Running setup.py install for mozrunner 04:04:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:04:27 INFO - Running setup.py install for mozscreenshot 04:04:27 INFO - Running setup.py install for moztest 04:04:27 INFO - Running setup.py install for mozversion 04:04:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:04:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:04:27 INFO - Cleaning up... 04:04:27 INFO - Return code: 0 04:04:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0e0e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', '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:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:04:27 INFO - Using env: {'DISPLAY': ':0', 04:04:27 INFO - 'HOME': '/home/cltbld', 04:04:27 INFO - 'LANG': 'en_US.UTF-8', 04:04:27 INFO - 'LANGUAGE': 'en_US:en', 04:04:27 INFO - 'LOGNAME': 'cltbld', 04:04:27 INFO - 'MAIL': '/var/mail/cltbld', 04:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:27 INFO - 'MOZ_NO_REMOTE': '1', 04:04:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:27 INFO - 'NO_EM_RESTART': '1', 04:04:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:27 INFO - 'PWD': '/builds/slave/test', 04:04:27 INFO - 'SHELL': '/bin/bash', 04:04:27 INFO - 'SHLVL': '1', 04:04:27 INFO - 'TERM': 'linux', 04:04:27 INFO - 'TMOUT': '86400', 04:04:27 INFO - 'USER': 'cltbld', 04:04:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', 04:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:27 INFO - '_': '/tools/buildbot/bin/python'} 04:04:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:04:27 INFO - Running setup.py (path:/tmp/pip-ZhqPgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:04:27 INFO - Running setup.py (path:/tmp/pip-Mr3Nwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:04:28 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:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:04:28 INFO - Running setup.py (path:/tmp/pip-ai2txk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:04:28 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:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:04:28 INFO - Running setup.py (path:/tmp/pip-NIAhzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:04:28 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:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:04:28 INFO - Running setup.py (path:/tmp/pip-49bOXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:04:28 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:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:04:28 INFO - Running setup.py (path:/tmp/pip-Evksyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:04:28 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:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:04:28 INFO - Running setup.py (path:/tmp/pip-z5etbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:04:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:04:28 INFO - Running setup.py (path:/tmp/pip-6muG8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:04:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:04:28 INFO - Running setup.py (path:/tmp/pip-aNHEKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:04:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:04:28 INFO - Running setup.py (path:/tmp/pip-hX3d9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:04:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:04:28 INFO - Running setup.py (path:/tmp/pip-TxSCoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:04:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:04:28 INFO - Running setup.py (path:/tmp/pip-k9KOdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:04:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:04:28 INFO - Running setup.py (path:/tmp/pip-bh_Kas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:04:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:04:28 INFO - Running setup.py (path:/tmp/pip-uwALfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:04:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:28 INFO - Running setup.py (path:/tmp/pip-tbEk6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:04:28 INFO - Running setup.py (path:/tmp/pip-zp89IN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:04:29 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:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:04:29 INFO - Running setup.py (path:/tmp/pip-lgqu0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:04:29 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:04:29 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:04:29 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:04:29 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:04:29 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:04:29 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:04:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:04:29 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:04:29 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:04:29 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:04:29 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:04:29 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:04:29 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:04:30 INFO - Downloading blessings-1.6.tar.gz 04:04:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:04:31 INFO - Installing collected packages: blessings 04:04:31 INFO - Running setup.py install for blessings 04:04:31 INFO - Successfully installed blessings 04:04:31 INFO - Cleaning up... 04:04:31 INFO - Return code: 0 04:04:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:04:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:04:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:04:31 INFO - Reading from file tmpfile_stdout 04:04:31 INFO - Current package versions: 04:04:31 INFO - argparse == 1.2.1 04:04:31 INFO - blessings == 1.6 04:04:31 INFO - blobuploader == 1.2.4 04:04:31 INFO - docopt == 0.6.1 04:04:31 INFO - manifestparser == 1.1 04:04:31 INFO - mozInstall == 1.12 04:04:31 INFO - mozcrash == 0.17 04:04:31 INFO - mozdebug == 0.1 04:04:31 INFO - mozdevice == 0.48 04:04:31 INFO - mozfile == 1.2 04:04:31 INFO - mozhttpd == 0.7 04:04:31 INFO - mozinfo == 0.9 04:04:31 INFO - mozleak == 0.1 04:04:31 INFO - mozlog == 3.1 04:04:31 INFO - moznetwork == 0.27 04:04:31 INFO - mozprocess == 0.22 04:04:31 INFO - mozprofile == 0.28 04:04:31 INFO - mozrunner == 6.11 04:04:31 INFO - mozscreenshot == 0.1 04:04:31 INFO - mozsystemmonitor == 0.0 04:04:31 INFO - moztest == 0.7 04:04:31 INFO - mozversion == 1.4 04:04:31 INFO - psutil == 3.1.1 04:04:31 INFO - requests == 1.2.3 04:04:31 INFO - wsgiref == 0.1.2 04:04:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0e0e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', '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:04:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:04:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:04:31 INFO - Using env: {'DISPLAY': ':0', 04:04:31 INFO - 'HOME': '/home/cltbld', 04:04:31 INFO - 'LANG': 'en_US.UTF-8', 04:04:31 INFO - 'LANGUAGE': 'en_US:en', 04:04:31 INFO - 'LOGNAME': 'cltbld', 04:04:31 INFO - 'MAIL': '/var/mail/cltbld', 04:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:31 INFO - 'MOZ_NO_REMOTE': '1', 04:04:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:31 INFO - 'NO_EM_RESTART': '1', 04:04:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:31 INFO - 'PWD': '/builds/slave/test', 04:04:31 INFO - 'SHELL': '/bin/bash', 04:04:31 INFO - 'SHLVL': '1', 04:04:31 INFO - 'TERM': 'linux', 04:04:31 INFO - 'TMOUT': '86400', 04:04:31 INFO - 'USER': 'cltbld', 04:04:31 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', 04:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:31 INFO - '_': '/tools/buildbot/bin/python'} 04:04:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:04:31 INFO - Cleaning up... 04:04:31 INFO - Return code: 0 04:04:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe0e0e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', '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:04:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:04:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:04:31 INFO - Using env: {'DISPLAY': ':0', 04:04:31 INFO - 'HOME': '/home/cltbld', 04:04:31 INFO - 'LANG': 'en_US.UTF-8', 04:04:31 INFO - 'LANGUAGE': 'en_US:en', 04:04:31 INFO - 'LOGNAME': 'cltbld', 04:04:31 INFO - 'MAIL': '/var/mail/cltbld', 04:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:31 INFO - 'MOZ_NO_REMOTE': '1', 04:04:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:31 INFO - 'NO_EM_RESTART': '1', 04:04:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:31 INFO - 'PWD': '/builds/slave/test', 04:04:31 INFO - 'SHELL': '/bin/bash', 04:04:31 INFO - 'SHLVL': '1', 04:04:31 INFO - 'TERM': 'linux', 04:04:31 INFO - 'TMOUT': '86400', 04:04:31 INFO - 'USER': 'cltbld', 04:04:31 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', 04:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:31 INFO - '_': '/tools/buildbot/bin/python'} 04:04:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:31 INFO - Downloading/unpacking jsonschema 04:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:04:33 INFO - Downloading/unpacking functools32 (from jsonschema) 04:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:34 INFO - Downloading functools32-3.2.3-2.tar.gz 04:04:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:04:34 INFO - warning: no files found matching '*.txt' 04:04:34 INFO - no previously-included directories found matching 'build' 04:04:34 INFO - no previously-included directories found matching 'dist' 04:04:34 INFO - no previously-included directories found matching '.git*' 04:04:34 INFO - Installing collected packages: jsonschema, functools32 04:04:34 INFO - Running setup.py install for functools32 04:04:34 INFO - warning: no files found matching '*.txt' 04:04:34 INFO - no previously-included directories found matching 'build' 04:04:34 INFO - no previously-included directories found matching 'dist' 04:04:34 INFO - no previously-included directories found matching '.git*' 04:04:34 INFO - Successfully installed jsonschema functools32 04:04:34 INFO - Cleaning up... 04:04:34 INFO - Return code: 0 04:04:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:04:34 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:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:34 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:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:34 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 0x7fbe0e0e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', '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:04:34 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:04:34 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:04:34 INFO - Using env: {'DISPLAY': ':0', 04:04:34 INFO - 'HOME': '/home/cltbld', 04:04:34 INFO - 'LANG': 'en_US.UTF-8', 04:04:34 INFO - 'LANGUAGE': 'en_US:en', 04:04:34 INFO - 'LOGNAME': 'cltbld', 04:04:34 INFO - 'MAIL': '/var/mail/cltbld', 04:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:34 INFO - 'MOZ_NO_REMOTE': '1', 04:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:34 INFO - 'NO_EM_RESTART': '1', 04:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:34 INFO - 'PWD': '/builds/slave/test', 04:04:34 INFO - 'SHELL': '/bin/bash', 04:04:34 INFO - 'SHLVL': '1', 04:04:34 INFO - 'TERM': 'linux', 04:04:34 INFO - 'TMOUT': '86400', 04:04:34 INFO - 'USER': 'cltbld', 04:04:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', 04:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:34 INFO - '_': '/tools/buildbot/bin/python'} 04:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:34 INFO - Downloading/unpacking flake8 04:04:34 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:04:34 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:04:34 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:04:34 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:04:34 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:04:34 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:04:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:04:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:04:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:04:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:04:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:04:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:04:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:04:37 INFO - no previously-included directories found matching 'docs/_build' 04:04:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:04:37 INFO - Running setup.py install for pep8 04:04:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:04:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:04:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:04:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:04:37 INFO - no previously-included directories found matching 'docs/_build' 04:04:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:04:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:04:37 INFO - Cleaning up... 04:04:37 INFO - Return code: 0 04:04:37 INFO - Running post-action listener: _resource_record_post_action 04:04:37 INFO - Running post-action listener: _start_resource_monitoring 04:04:37 INFO - Starting resource monitoring. 04:04:37 INFO - ##### 04:04:37 INFO - ##### Running install step. 04:04:37 INFO - ##### 04:04:37 INFO - Running pre-action listener: _resource_record_pre_action 04:04:37 INFO - Running main action method: install 04:04:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:04:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:04:37 INFO - Reading from file tmpfile_stdout 04:04:37 INFO - Detecting whether we're running mozinstall >=1.0... 04:04:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:04:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:04:37 INFO - Reading from file tmpfile_stdout 04:04:37 INFO - Output received: 04:04:37 INFO - Usage: mozinstall [options] installer 04:04:37 INFO - Options: 04:04:37 INFO - -h, --help show this help message and exit 04:04:37 INFO - -d DEST, --destination=DEST 04:04:37 INFO - Directory to install application into. [default: 04:04:37 INFO - "/builds/slave/test"] 04:04:37 INFO - --app=APP Application being installed. [default: firefox] 04:04:37 INFO - mkdir: /builds/slave/test/build/application 04:04:37 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:04:37 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:04:53 INFO - Reading from file tmpfile_stdout 04:04:53 INFO - Output received: 04:04:53 INFO - /builds/slave/test/build/application/firefox/firefox 04:04:53 INFO - Running post-action listener: _resource_record_post_action 04:04:53 INFO - ##### 04:04:53 INFO - ##### Running run-tests step. 04:04:53 INFO - ##### 04:04:53 INFO - Running pre-action listener: _resource_record_pre_action 04:04:53 INFO - Running main action method: run_tests 04:04:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:04:53 INFO - Python 2.7.3 04:04:53 INFO - Return code: 0 04:04:53 INFO - grabbing minidump binary from tooltool 04:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:53 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 0x14f9410>, '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 0x14fa310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fa7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:04:53 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:04:53 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:04:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:04:53 INFO - Return code: 0 04:04:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:04:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:04:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:04:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:04:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:04:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:04:54 INFO - Return code: 0 04:04:54 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-020', '--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:04:54 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-020 --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:04:54 INFO - Using env: {'DISPLAY': ':0', 04:04:54 INFO - 'HOME': '/home/cltbld', 04:04:54 INFO - 'LANG': 'en_US.UTF-8', 04:04:54 INFO - 'LANGUAGE': 'en_US:en', 04:04:54 INFO - 'LOGNAME': 'cltbld', 04:04:54 INFO - 'MAIL': '/var/mail/cltbld', 04:04:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:04:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:54 INFO - 'MOZ_NO_REMOTE': '1', 04:04:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:54 INFO - 'NO_EM_RESTART': '1', 04:04:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:54 INFO - 'PWD': '/builds/slave/test', 04:04:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:04:54 INFO - 'SHELL': '/bin/bash', 04:04:54 INFO - 'SHLVL': '1', 04:04:54 INFO - 'TERM': 'linux', 04:04:54 INFO - 'TMOUT': '86400', 04:04:54 INFO - 'USER': 'cltbld', 04:04:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274', 04:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:54 INFO - '_': '/tools/buildbot/bin/python'} 04:04:54 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-020', '--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:04:54 INFO - mozversion application_buildid: 20160510142413 04:04:54 INFO - mozversion application_changeset: 1dd42a351054c5b697873d647169019d4d77d762 04:04:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:04:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:04:54 INFO - mozversion application_name: Firefox 04:04:54 INFO - mozversion application_remotingname: firefox-dev 04:04:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:04:54 INFO - mozversion application_vendor: Mozilla 04:04:54 INFO - mozversion application_version: 48.0a2 04:04:54 INFO - mozversion platform_buildid: 20160510142413 04:04:54 INFO - mozversion platform_changeset: 1dd42a351054c5b697873d647169019d4d77d762 04:04:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:04:54 INFO - mozversion platform_version: 48.0a2 04:04:54 INFO - using testdate: 1462964694 04:04:54 INFO - actual date: 1462964694 04:04:54 INFO - starting webserver on 'localhost:50451' 04:04:54 INFO - SUITE-START | Running 2 tests 04:04:54 INFO - TEST-START | dromaeo_css 04:04:54 INFO - operating with platform_type : linux_ 04:04:54 INFO - Initialising browser for dromaeo_css test... 04:04:54 INFO - TEST-INFO | started process 18702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjstTCw/profile http://localhost:50451/getInfo.html) 04:04:59 INFO - PROCESS | 18702 | __metrics Screen width/height:1600/1200 04:04:59 INFO - PROCESS | 18702 | colorDepth:24 04:04:59 INFO - PROCESS | 18702 | Browser inner width/height: 1024/697 04:04:59 INFO - PROCESS | 18702 | __metrics 04:05:00 ERROR - PROCESS | 18702 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:05:01 INFO - TEST-INFO | 18702: exit 0 04:05:01 INFO - Browser initialized. 04:05:01 INFO - Running cycle 1/1 for dromaeo_css test... 04:05:01 INFO - TEST-INFO | started process 18792 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjstTCw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:05:12 INFO - PROCESS | 18792 | RSS: Main: 141987840 04:05:12 INFO - PROCESS | 18792 | 04:06:03 INFO - PROCESS | 18792 | 1462964763908 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:08:11 INFO - PROCESS | 18792 | Cycle 1(1): loaded http://localhost:50451/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50451/tests/dromaeo/cssquery-ext.html) 04:08:12 INFO - PROCESS | 18792 | RSS: Main: 250572800 04:08:12 INFO - PROCESS | 18792 | 04:11:14 INFO - PROCESS | 18792 | Cycle 1(1): loaded http://localhost:50451/tests/dromaeo/cssquery-ext.html (next: http://localhost:50451/tests/dromaeo/cssquery-jquery.html) 04:11:15 INFO - PROCESS | 18792 | RSS: Main: 222330880 04:11:15 INFO - PROCESS | 18792 | 04:14:17 INFO - PROCESS | 18792 | Cycle 1(1): loaded http://localhost:50451/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50451/tests/dromaeo/cssquery-mootools.html) 04:14:17 INFO - PROCESS | 18792 | RSS: Main: 218583040 04:14:17 INFO - PROCESS | 18792 | 04:17:19 INFO - PROCESS | 18792 | Cycle 1(1): loaded http://localhost:50451/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50451/tests/dromaeo/cssquery-prototype.html) 04:17:20 INFO - PROCESS | 18792 | RSS: Main: 216449024 04:17:20 INFO - PROCESS | 18792 | 04:20:22 INFO - PROCESS | 18792 | Cycle 1(1): loaded http://localhost:50451/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50451/tests/dromaeo/cssquery-yui.html) 04:20:23 INFO - PROCESS | 18792 | RSS: Main: 183492608 04:20:23 INFO - PROCESS | 18792 | 04:23:25 INFO - PROCESS | 18792 | Cycle 1(1): loaded http://localhost:50451/tests/dromaeo/cssquery-yui.html (next: http://localhost:50451/tests/dromaeo/cssquery-dojo.html) 04:23:25 INFO - PROCESS | 18792 | RSS: Main: 241766400 04:23:25 INFO - PROCESS | 18792 | 04:23:25 INFO - PROCESS | 18792 | __start_tp_report 04:23:25 INFO - PROCESS | 18792 | _x_x_mozilla_page_load 04:23:25 INFO - PROCESS | 18792 | _x_x_mozilla_page_load_details 04:23:25 INFO - PROCESS | 18792 | |i|pagename|runs| 04:23:25 INFO - PROCESS | 18792 | |0;dojo.html;3247.3829972305266;3310.3710295043948;3339;3363.041533163046;3380.9661903380957;5482.259894914186;5493.862653433661;5495.999999999995;5502.312210973629;5510.779568817243;5481.835544933659;5521.613487055908;5523.28197334346;5530.6128570999945;5559.777608895639;4929.137400954819;4982.750862456881;5073;5130.256112863633;5153.252778347156;4986.95273992462;5034.119029169899;5080.187170052793;5081.98360327934;5086.821961231358;4997.275395067713;5039.874003149932;5062.898742025157;5069;5075.9492405076035;5076.517730815566;5100.413452452941;5120.92318615221;5122.949795291956;5148.2020286855595;4858.02839432115;4951.653384263103;5022.196448568212;5023.748812559394;5052.747362631853;5417.295751552273;5417.485338892799;5448.809291674812;5465.480779325958;5477;5874.441928016831;5921.73352199152;5930.140129681172;5932.288125424977;5932.644041357532;5889.528837692974;5954.047352423591;5958.731857066442;6012;6018.96990515049;5503.7798488060425;5507.807226747044;5508.531774799147;5540.750666220029;5542.168674698787;5970.582059255898;6057.3336932937345;6070.878582428327;6073.18012068374;6079.513638908877;5856.238688970492;5898.997170481029;5904.645721256738;5905.704714764244;5908.675022873697;5892.616979896293;5899.734511946973;5899.793507227227;5905.911411328833;5921.5558833086825;5744.540436765133;5841.620294680833;5867.647941123546;5870.73581688825;5876.529877609781;5915.58590898633;5943.5839491236065;5945.316288626776;5951.1073338999495;5988.640681559121;4502.189605870974;4515.75163366018;4517.954820451753;4521.253993091103;4545.636349092131;3957.050307926077;4003;4057.533383660858;4057.9797101014897;4107.424960505532;5495.450454954553;5514.779408823602;5518.392976772552;5520.309961254843;5528.917066244009;5844.532437404998;5869.618474799125;5875.089361149029;5875.941240587625;5882.705864706748;5411.215373770781;5542.11326187808;5586.301712285965;5657.264555607827;5675.063614503643;4678.485366609671;4683.765811709401;4686.367340409001;4695.201815691341;4716.3868697069165;6075.422834830684;6084.330723620398;6086.421789929949;6089.269287685417;6102.450779429784;5820.592558520862;5916.73374698131;5974.581779275409;5987.221661184192;6009.098635204754;6165.599236049642;6170.290416602148;6184.907226391698;6188.226471691039;6196.225471816023;5689.1750696148;5826.679532625746;5834.212381328466;5834.416558344132;5838.824835254949;5863.618864773776;5909.143174239625;5932.288125424977;5939.227900372924;5959.1657167995645;5737.454941780524;5750.367459579526;5751.1373294006235;5755.827325180251;5760.222369980167;5497.065498865122;5736.4550367716665;5737.196792449144;5744.167095771007;5767.279090113736;5693.259876216065;5694;5697.7151142443545;5702.543796496353;5731.799387021434;5796.42035796417;5803.680797556175;5830.679312637845;5833.82498525045;5838.591298609226;5559;5664.433556644302;5704.657720536781;5737.8565535861935;5737.942620573908 04:23:25 INFO - PROCESS | 18792 | |1;ext.html;660.3462572053666;669.477807310298;680.4454369688704;682.2699711308901;759.2255898983034;33177.502337464924;39369.80315098424;40223.79888100563;40279;40296.79851600738;42726.786366068125;43453;43886.78056609721;43899.3415098773;44059.55940440595;8036.959815200945;8899.599518021689;9103.180713735763;10460.058594726474;10656.360618362884;10519.421431821247;10628.57485700575;10661.78676426471;10663.14694824416;10664.893351066507;10651;10672.35965842048;10727.08819750322;10740.78518429631;10742.946285268563;8285.50286982783;10502.159827213844;10681.946590266998;10687.465626718711;10720.839187412195;10675.252732308742;10832.40421776802;10843.457827108692;10849.132069434427;10850.403227822466;39984.400233996515;40420.1915961682;40544.594554054675;40571.188576228604;40587.391189132184;3707.29561383339;3743.737938344317;3807.8667246646232;3819.4843696100947;3877.651011408987;33476.16309592255;33952.49071263933;34061.48907766386;34182.658173418444;34208.65791342079;4514.616257618107;4556.430446194226;4590.449146102489;4594.264917613166;4630.675852690313;309474;311139;311659;311761;311826;40246.79876600657;68132.3186768136;69371;69409;69443.65278173678;39008.60991390106;39302.266284702906;39394.212115757524;39484.210315794095;39521.20957580832;16246.75629865553;16881.66236675284;17108.657826843395;17111.486655400357;17124.315027398763;13888.930555347159;14301.499447519494;14302.070365426214;14320.713585728436;14330.283485825876;9442.10300021497;9491.525423728925;9491.810163796685;9524.523773811281;9551.61793528265;3655.8903232903053;3825.0437390652337;3825.598312177237;3829.4447305140598;3834.328992426314;1100.526773487408;1139.4758411130972;1160.8665003524534;1179.5753528729651;1237.6101528018646;33187.66812331894;33520.16199595029;33805.49291760626;33855;34024.31951360959;1217.9264479626816;1251.3492983648453;1277.240042174923;1284.9614511564669;1390.2840037380756;17845.616660431475;18007.549811254823;18047.2640510065;18093;18118.818811811976;447778;513564;521589;522070;522351;61496.69251653802;62068;62068.689656552335;62302.37697623057;62603;1449.0436312034008;1534.1178822177292;1558.7428074367829;1567.9608009799617;1629.6577718678973;30978.380432390775;33773.66226337705;33811.15472113217;33838.32323353568;34553.136171595914;51014;51565.22652160146;51579;51659.2251116226;51707.48292517027;341893;343930;344211;344702;344895;27740.861295694198;30966.53550196704;31840.203994900312;31934;31951.36097277995;47310;51722;51940;52048.479515204366;52511.47488525066;37227.255454891296;37369.813150934075;37608;37741.81129094337;38003;36986.44520332143;37780.2443951114;38146;38215.80892095522;38690.613093869826;39659.60340396559;39819.60180398275;45523.77238113788;46482.767586161855;46842;32619;33842.32315353728;34106;34157.829210853786;34483.65516344804;27998.440031198854;29195.562066569444;29248.26879328034;29343.85328073346;29492.852535737184 04:23:25 INFO - PROCESS | 18792 | |2;jquery.html;422.72100413726935;437.949635791884;440.86553601151655;440.9911801763965;442.7166613367443;18179.36372226972;18359.632807343845;18466.722999155023;19124.713129303054;20068;19461.902690486564;19484.3438307744;19919;19958.60082798343;19969.900150499263;5649.887002259952;5663.5186009189165;5813.389594092623;5817.505512031483;5818.185454036438;5733.48398644122;5799.391063938289;5809.215755872967;5815.098659707752;5836.9124463133085;5676.2620859288445;5688.579451091484;5790.10253410722;5828.271466066742;5838.824835254928;5657.688827114507;5663.8584035399035;5671.914921276184;5676.517496012844;5686.715664216773;5155.484451554852;5160.7419629018395;5451.618386712932;5715.199872017879;5719.59962802604;13371.465141394332;13537.39081741324;13653.180809151383;13769.380377883019;13901.304934753221;2396.161343529768;2408.1812183857573;2470;2498.912538061177;2599.7270286619823;10022.448765317904;10157.898421015769;10274.7431314217;10536.525856336484;10626.203034772423;1945.503896506396;1951.9219231230734;2019.2730616977876;2061.402193363923;2111.915523379063;77743;84997.57501212516;85554.57222713971;85681;85847;11032.172587056002;11384;11411.315321080761;11508.251963622337;11633.6509904703;16124;16142.950708203929;16318.265678044516;16415.83584164143;16459.177041147894;8879;8896.8665470018;8950.328725345495;8976.640934362553;9016.18854303116;8791;8809.823803524021;8886.4668119913;8896.73309800694;8972.685955991508;4947.82682606107;4994;5013.5989120870245;5014.6991180529285;5046.697198168122;1787.767590213264;2029.1680411031407;2094.654382026979;2128.936131916045;2159.9460013499474;473.5974421741492;510.6093838213769;954.0745476887408;1010.686687126993;1212.1151559361715;11613.535458581562;11837.76324473523;11854.822177667342;11879.168458208016;11946.163768536118;471.6839717389357;506.6124414822664;507.9441261461236;516.4499807704857;520.5601266929439;5940.168376427304;6479.092926990225;6517.315681853337;6554.508411869034;6556.082148499214;560282;562048;562955;573497;573917;95644;98900;101474.49262753638;101812;102753;518.3520599251011;521.7443452708146;525.4115390762371;526.4209369693383;527.575301881981;11144.2199046066;11327.603533876274;11370.602028928948;11416.372099534274;11443.42782860837;37894;39281;39571;39900.40149397819;39946.20107597773;51955;56549;58028.4197158023;58132.4186758127;58787.412125878196;8881.555922203735;8938.68714594986;9054.094590540893;9109.498977556297;9139.634414623606;12773.425195866022;13166.473341066634;13453;13470.787629113427;13622.386992585556;11479.540818367172;11512.481938312629;11761.47073381717;12221.144519883523;12369.814452783035;11263.549458021587;11672.47473863695;11864.22882512634;11881.22772019816;11950.880491194977;11870.228435152034;12137.69655758613;12214.328211948428;12215.938920305342;12307.20003199789;8483.957580212307;8660.740177794676;8823.69117080899;8953.955230223808;9029.006809251108;9235.953820230856;11580.826287605862;11612.187146899636;11685.182037257651;11947.641570752892 04:23:25 INFO - PROCESS | 18792 | |3;mootools.html;1453.3968403112708;1580.5100418870152;1583.2056420417957;1755.5786611213305;1873.8969356685377;7769.611519424027;7984.640691168896;7988.400869934756;7991.120976692574;8004.439689221756;7797.220277972214;7955.0453945526615;7964.362850971923;7976.242256985592;7976.641051152697;2062.711220429141;2299.4366380236866;2338.918137865175;2367.1005018093188;2370.4073981504625;2367.8105751539833;2403.291029146406;2407.927762167129;2408.5664580375524;2409.277216834951;2194.7585765565773;2241.9215327463544;2243.1363924888874;2243.5288589396246;2248.651459023854;2113.6301147299237;2240.2383189715492;2282.931512054641;2283.942901427469;2286.7141607299086;2225.8441909066373;2259.4803195265017;2261.366817291161;2276.3512398966213;2278.7721227877246;7543.547387156733;7587.772366829004;7598;7620.276073772982;7622.199669034782;5009.624278179152;5117.181250999822;5121.974390128025;5123.2827404163445;5205.661631993946;3340.916477088092;3355.261842394669;3398.490226466025;3405.0465869556315;3434.845431955568;1135.9716007099805;1200.3938011304322;1205.3310412720937;1222.3888055972013;1282.1729984160258;10474.79050418995;10565.788684226349;10585.523651435704;10606.734831629194;10622.25644204906;4307.956920430818;4369.300911854151;4385.824567017347;4401.141777353385;4403.559644035571;9227.169554740105;9229.307801914749;9234.307426943005;9271.67549135777;9274.768130796783;4592.334111553872;4995.675281106789;4999.125153098194;4999.825006124768;5006.69959802413;4664.440267167962;4677.2750223715375;4721.693089949143;4723.244280915037;4749.762511874393;3923.156521347924;3976.1252524444576;4006.399040144002;4045.8583949561626;4067.2068946555137;1291.2639795316768;1314.7107636320186;1329.5878277733934;1335.819664345301;1341.6578772413168;1023.3910823060268;1076.4779082145153;1083.669480808361;1093.1965005720788;1102.685734565661;5940.881182376328;6000.969995149996;6009.669468179292;6117.755289788359;6134.601250918676;492.07489918952143;493.437481271351;495.00503986986416;495.1928356778428;497.7138145566314;4171.749695018309;4179.477565304337;4192.3711443283755;4199.118185181085;4278.893027674333;9595.808083838285;9985.350952188084;9990.050945160343;10017.749556261006;10018.448985305733;9901.207903367713;9911.752206194758;9925.702228933143;9940.453275069796;9947.850782238273;7458.813529661802;7601.885971710429;7698.384129269645;7702;7716.5370077795515;5550.167474878801;5657.60396772222;5767.163761254678;5771.653700777967;5793.275840519935;8797.384183107377;8944.195022448012;9054.547272636473;9194.632214711337;9236.907630923874;9293.953530232306;9300.20948219409;9305.488198149167;9329.906700933176;9391.483468409304;7109.537880037781;7122.394596459152;7157.320054594805;7224.711011559479;7231.63841807918;7658.234176582298;7691.269329413697;7717.6527056281475;7727.459077864495;7756.806079848049;6869.519133660596;6963.442924566124;7025.508214424941;7039.155301363664;7194.172670143001;7033.402160816183;7096.361327480345;7115.715371385294;7168.498205125799;7185.173705023989;6561.80314590563;6751.628660423724;6777.830554236183;6778.694958726771;6781.728730850711;5024.84925452237;5042.243663450512;5162.483751624807;5209;5234.476552344888;5052.444231134646;5073.518015788494;5082.898342033065;5157.735362009601;5174.379074511083 04:23:25 INFO - PROCESS | 18792 | |4;prototype.html;343.7765452455905;353.8354665080737;354.7676272041813;355.3213362477668;355.539576248758;6291.370862913712;6296.748130074797;6323.462505687016;6362.745490180388;6382.712777924993;5876.618019828708;6126.050462178358;6216.191895053648;6248.84377890553;6300.05499175124;4794.808207671689;4836.564709176174;4842.999999999983;4843.031393721243;4849.175640141185;4828.686135401205;4841.443234028096;4857;4860.1008813369635;4860.902781944359;4613.861584152464;4672.4393072831135;4722;4725.763711814413;4737.289406589022;4707.482176960531;4770.045990801819;4773.355596994396;4774.952250477503;4796.400449943757;4219.409282700424;4226.661867050629;4229.873103806891;4233.428487154226;4240;6008.8497787555225;6015;6027.246594175728;6031.155638210654;6047.274327080734;5549.250851135085;5556;5560.7219639017885;5569.526590239834;5569.944300556983;6416.743330266784;6541.836454088639;6553.705083271217;6554.082428460019;6554.311797261266;4620.399348084761;4644.930326045112;4652.651051171142;4653.837115700934;4660.557247061523;6844.349786770299;6858.177018757731;6872.965635171842;6884.345987131214;6898.862022759567;4769.2130798417875;4771.71369717818;4771.809127634856;4779.713217206979;4783.306420569068;4840.031993601294;4843.329051477234;4845;4848.7090774552935;4849.102915960488;5369.865753356197;5462.481064298885;5467.425920278393;5542.3903370630005;5542.806001789918;6563.310852360529;6589.967050164814;6593.274739778621;6602.900956485657;6608.107905432801;1615.579949213213;1659.2533359988054;1663.534210421084;1703.1824724132487;1704.4630941253465;1110.5724296146043;1140.8516892803882;1142.4459137318395;1151.6026970695098;1154.1516985016005;6351.237851457762;6366.076918846741;6367.2040994874715;6376.7130479128555;6377.649229292433;6772.55978361405;6773.62745049027;6776.559523630948;6788.558743681645;6804.591724496546;6316.178896743394;6318.873622527615;6319.652419116993;6322.336154703782;6340.873182536416;3614.530111085542;3664.88221092564;3666.8533258669886;3670.4127339625534;3671.284099600552;6864.176298844171;7029.297070293032;7031.1211098612675;7035.859282814315;7041.507094503438;6874.450043996469;6883.862322753517;6888.827779305458;6890.069840571458;6902.93097069033;6993.440524758007;6997.440204783605;7004.929950700428;7011.579305241804;7016.333448322402;6712.060311556484;6733.326667333227;6745;6756.831079223059;6764.729410823512;6624.701888415129;6657.600543967377;6818.454523638196;6825.965870170618;6842.110525631636;7148.857022859618;7160.10498687664;7201.459890508128;7205.315495027964;7209.531380460463;4671.205894997791;4720.5043470436485;4734.479207287264;4735.59747421473;4737.07627012743;6629.370209830058;6907.654617269016;6915.412189963708;6922.446204303745;6932.376086152271;6565.835854103686;6701.597904125768;6715.059891615276;6732.562383445061;6735.1244338237675;6613.27254002069;6617.305182955721;6631.535792494672;6643.435307998874;6667.566608170453;6575.24384695747;6603.900941485786;6618.404343609098;6620.801375958729;6627;6588.571742836701;6707.832304192434;6711.194656641234;6718.798436046926;6734.831629209309;6496.870062598627;6533.118029066015;6533.738650453929;6538.248101468392;6543.247526534509 04:23:25 INFO - PROCESS | 18792 | |5;yui.html;817.7996390884234;822.9012518497777;918.386575290839;949.45406391325;969.8205831921096;15478.148701821396;15802.13088280144;15842.049477031373;15847.524574262761;15867;14243.287835608204;14311.212883291415;14318;14334.283285835692;14340;741.7737590035038;755.5655498088594;883.9690610828623;903.408267584733;915.0620613870769;905.0632595263903;912.543728135932;912.9817403651923;913.2009491694768;913.968011119611;951.7668171298008;952.2953014769056;953.1231267234161;953.5232383808096;958.7411398922287;791.3234184772024;951.5527701980059;972.7568107973007;973.0512750068697;974.2644303550774;686.8694947959922;690.1717938473802;690.6546726636682;691.2776148924386;692.0207905813268;13460.326983650779;13663.316834158253;13674.111182773187;13710.45158193671;13720.176789392668;14182.361793719307;14329.570112896525;14591.197484138474;14955.775663365059;15188.240587970668;11856.644300670907;11889.405529723479;11898.107641926803;12138.939305303506;12151.939240303831;4055.371417430303;4066.5120185577625;4119.629233369011;4129.834806607732;4142.06803469217;58144;58237;58241.12638310387;58599;59723;11720.296782193096;11807.645770626896;11988.546417281632;12055.819162712567;12337.876621233672;22147.778522214892;22287.55424891493;22312.553748925257;22784.658230126563;22908.312750617508;8882.289416846637;8953.194212520904;8956.462612243286;8974.102589740975;9003.414778039538;4957;5032.3961124665275;5069.188929771219;5137.768800403916;5144.536991670768;3553.3959226931483;3609.5488063992;3611.747177697536;3615.349237137288;3617.330793803155;595.8033848829875;623.9438450539474;643.2827397451807;707.2043950555625;707.3033062433499;651.8989556618732;723.5767076260447;744.1888341707564;777.2227772227773;803.9035315762029;9158.175764181256;9798.75503112428;9864.556094975744;9894.356866803779;10026.348287361297;561.2899681902396;581.2501872584319;662.0929326822188;680.883351303862;697.9651017449107;4623.445186577632;4686.759430644053;4834.419869615598;4938.925916111261;4960.950390496121;67353.66323168353;67495.32504674989;69493;69801;69882.65058674673;55735.163972540446;55978.72010639921;56539;58743.41256587465;58905;47486.5251347489;47669;48879.26681099786;49350.75324623426;50458;10364.222683298633;10557.366558006544;10716.839247411452;10848.240623156304;10865.674029779118;37696.246075078896;38279;39057.609423906535;39282.410763839136;39301.60698392979;44966.77516612396;48425.757871210415;50162;50407.747961259956;51776.482235177165;12611.495540178657;12798.360081995677;12839.037072219808;12985.28580928058;13220.272884991418;12601;12905.612831615066;13016.414261358452;13164.60506184816;13989.370478328703;12983.41574629125;13042.739145217232;13090.672733181747;13318.400671969592;13407.128536645087;13064.738705225653;13167.209967401986;13285;13452.1256118352;13785.103968242032;12917.870821291666;13622.250776207404;13916.165030098227;14238.928805355907;14349.64125896861;11258.09935205198;11383.260088094248;11495.885041149482;11508;11514;11271.718207044889;11353.545858165911;11525.193236473702;11535.480903359201;11767.293962362286 04:23:25 INFO - PROCESS | 18792 | __end_tp_report 04:23:25 INFO - PROCESS | 18792 | __start_cc_report 04:23:25 INFO - PROCESS | 18792 | _x_x_mozilla_cycle_collect,889 04:23:25 INFO - PROCESS | 18792 | __end_cc_report 04:23:25 INFO - PROCESS | 18792 | __startTimestamp1462965805897__endTimestamp 04:23:25 INFO - PROCESS | 18792 | 04:23:25 INFO - PROCESS | 18792 | ------- Summary: start ------- 04:23:25 INFO - PROCESS | 18792 | Number of tests: 6 04:23:25 INFO - PROCESS | 18792 | 04:23:25 INFO - PROCESS | 18792 | [#0] dojo.html Cycles:165 Average:5481.42 Median:5702.54 stddev:619.12 (10.9%) stddev-sans-first:595.70 04:23:25 INFO - PROCESS | 18792 | Values: 3247.4 3310.4 3339.0 3363.0 3381.0 5482.3 5493.9 5496.0 5502.3 5510.8 5481.8 5521.6 5523.3 5530.6 5559.8 4929.1 4982.8 5073.0 5130.3 5153.3 4987.0 5034.1 5080.2 5082.0 5086.8 4997.3 5039.9 5062.9 5069.0 5075.9 5076.5 5100.4 5120.9 5122.9 5148.2 4858.0 4951.7 5022.2 5023.7 5052.7 5417.3 5417.5 5448.8 5465.5 5477.0 5874.4 5921.7 5930.1 5932.3 5932.6 5889.5 5954.0 5958.7 6012.0 6019.0 5503.8 5507.8 5508.5 5540.8 5542.2 5970.6 6057.3 6070.9 6073.2 6079.5 5856.2 5899.0 5904.6 5905.7 5908.7 5892.6 5899.7 5899.8 5905.9 5921.6 5744.5 5841.6 5867.6 5870.7 5876.5 5915.6 5943.6 5945.3 5951.1 5988.6 4502.2 4515.8 4518.0 4521.3 4545.6 3957.1 4003.0 4057.5 4058.0 4107.4 5495.5 5514.8 5518.4 5520.3 5528.9 5844.5 5869.6 5875.1 5875.9 5882.7 5411.2 5542.1 5586.3 5657.3 5675.1 4678.5 4683.8 4686.4 4695.2 4716.4 6075.4 6084.3 6086.4 6089.3 6102.5 5820.6 5916.7 5974.6 5987.2 6009.1 6165.6 6170.3 6184.9 6188.2 6196.2 5689.2 5826.7 5834.2 5834.4 5838.8 5863.6 5909.1 5932.3 5939.2 5959.2 5737.5 5750.4 5751.1 5755.8 5760.2 5497.1 5736.5 5737.2 5744.2 5767.3 5693.3 5694.0 5697.7 5702.5 5731.8 5796.4 5803.7 5830.7 5833.8 5838.6 5559.0 5664.4 5704.7 5737.9 5737.9 04:23:25 INFO - PROCESS | 18792 | 04:23:25 INFO - PROCESS | 18792 | [#1] ext.html Cycles:180 Average:55331.71 Median:189724.07 stddev:104869.86 (55.3%) stddev-sans-first:105083.71 04:23:25 INFO - PROCESS | 18792 | Values: 660.3 669.5 680.4 682.3 759.2 33177.5 39369.8 40223.8 40279.0 40296.8 42726.8 43453.0 43886.8 43899.3 44059.6 8037.0 8899.6 9103.2 10460.1 10656.4 10519.4 10628.6 10661.8 10663.1 10664.9 10651.0 10672.4 10727.1 10740.8 10742.9 8285.5 10502.2 10681.9 10687.5 10720.8 10675.3 10832.4 10843.5 10849.1 10850.4 39984.4 40420.2 40544.6 40571.2 40587.4 3707.3 3743.7 3807.9 3819.5 3877.7 33476.2 33952.5 34061.5 34182.7 34208.7 4514.6 4556.4 4590.4 4594.3 4630.7 309474.0 311139.0 311659.0 311761.0 311826.0 40246.8 68132.3 69371.0 69409.0 69443.7 39008.6 39302.3 39394.2 39484.2 39521.2 16246.8 16881.7 17108.7 17111.5 17124.3 13888.9 14301.5 14302.1 14320.7 14330.3 9442.1 9491.5 9491.8 9524.5 9551.6 3655.9 3825.0 3825.6 3829.4 3834.3 1100.5 1139.5 1160.9 1179.6 1237.6 33187.7 33520.2 33805.5 33855.0 34024.3 1217.9 1251.3 1277.2 1285.0 1390.3 17845.6 18007.5 18047.3 18093.0 18118.8 447778.0 513564.0 521589.0 522070.0 522351.0 61496.7 62068.0 62068.7 62302.4 62603.0 1449.0 1534.1 1558.7 1568.0 1629.7 30978.4 33773.7 33811.2 33838.3 34553.1 51014.0 51565.2 51579.0 51659.2 51707.5 341893.0 343930.0 344211.0 344702.0 344895.0 27740.9 30966.5 31840.2 31934.0 31951.4 47310.0 51722.0 51940.0 52048.5 52511.5 37227.3 37369.8 37608.0 37741.8 38003.0 36986.4 37780.2 38146.0 38215.8 38690.6 39659.6 39819.6 45523.8 46482.8 46842.0 32619.0 33842.3 34106.0 34157.8 34483.7 27998.4 29195.6 29248.3 29343.9 29492.9 04:23:25 INFO - PROCESS | 18792 | 04:23:25 INFO - PROCESS | 18792 | [#2] jquery.html Cycles:180 Average:30683.51 Median:439.41 stddev:93348.49 (21244.2%) stddev-sans-first:93582.70 04:23:25 INFO - PROCESS | 18792 | Values: 422.7 437.9 440.9 441.0 442.7 18179.4 18359.6 18466.7 19124.7 20068.0 19461.9 19484.3 19919.0 19958.6 19969.9 5649.9 5663.5 5813.4 5817.5 5818.2 5733.5 5799.4 5809.2 5815.1 5836.9 5676.3 5688.6 5790.1 5828.3 5838.8 5657.7 5663.9 5671.9 5676.5 5686.7 5155.5 5160.7 5451.6 5715.2 5719.6 13371.5 13537.4 13653.2 13769.4 13901.3 2396.2 2408.2 2470.0 2498.9 2599.7 10022.4 10157.9 10274.7 10536.5 10626.2 1945.5 1951.9 2019.3 2061.4 2111.9 77743.0 84997.6 85554.6 85681.0 85847.0 11032.2 11384.0 11411.3 11508.3 11633.7 16124.0 16143.0 16318.3 16415.8 16459.2 8879.0 8896.9 8950.3 8976.6 9016.2 8791.0 8809.8 8886.5 8896.7 8972.7 4947.8 4994.0 5013.6 5014.7 5046.7 1787.8 2029.2 2094.7 2128.9 2159.9 473.6 510.6 954.1 1010.7 1212.1 11613.5 11837.8 11854.8 11879.2 11946.2 471.7 506.6 507.9 516.4 520.6 5940.2 6479.1 6517.3 6554.5 6556.1 560282.0 562048.0 562955.0 573497.0 573917.0 95644.0 98900.0 101474.5 101812.0 102753.0 518.4 521.7 525.4 526.4 527.6 11144.2 11327.6 11370.6 11416.4 11443.4 37894.0 39281.0 39571.0 39900.4 39946.2 51955.0 56549.0 58028.4 58132.4 58787.4 8881.6 8938.7 9054.1 9109.5 9139.6 12773.4 13166.5 13453.0 13470.8 13622.4 11479.5 11512.5 11761.5 12221.1 12369.8 11263.5 11672.5 11864.2 11881.2 11950.9 11870.2 12137.7 12214.3 12215.9 12307.2 8484.0 8660.7 8823.7 8954.0 9029.0 9236.0 11580.8 11612.2 11685.2 11947.6 04:23:25 INFO - PROCESS | 18792 | 04:23:25 INFO - PROCESS | 18792 | [#3] mootools.html Cycles:180 Average:5410.31 Median:5062.98 stddev:2891.90 (57.1%) stddev-sans-first:2884.72 04:23:25 INFO - PROCESS | 18792 | Values: 1453.4 1580.5 1583.2 1755.6 1873.9 7769.6 7984.6 7988.4 7991.1 8004.4 7797.2 7955.0 7964.4 7976.2 7976.6 2062.7 2299.4 2338.9 2367.1 2370.4 2367.8 2403.3 2407.9 2408.6 2409.3 2194.8 2241.9 2243.1 2243.5 2248.7 2113.6 2240.2 2282.9 2283.9 2286.7 2225.8 2259.5 2261.4 2276.4 2278.8 7543.5 7587.8 7598.0 7620.3 7622.2 5009.6 5117.2 5122.0 5123.3 5205.7 3340.9 3355.3 3398.5 3405.0 3434.8 1136.0 1200.4 1205.3 1222.4 1282.2 10474.8 10565.8 10585.5 10606.7 10622.3 4308.0 4369.3 4385.8 4401.1 4403.6 9227.2 9229.3 9234.3 9271.7 9274.8 4592.3 4995.7 4999.1 4999.8 5006.7 4664.4 4677.3 4721.7 4723.2 4749.8 3923.2 3976.1 4006.4 4045.9 4067.2 1291.3 1314.7 1329.6 1335.8 1341.7 1023.4 1076.5 1083.7 1093.2 1102.7 5940.9 6001.0 6009.7 6117.8 6134.6 492.1 493.4 495.0 495.2 497.7 4171.7 4179.5 4192.4 4199.1 4278.9 9595.8 9985.4 9990.1 10017.7 10018.4 9901.2 9911.8 9925.7 9940.5 9947.9 7458.8 7601.9 7698.4 7702.0 7716.5 5550.2 5657.6 5767.2 5771.7 5793.3 8797.4 8944.2 9054.5 9194.6 9236.9 9294.0 9300.2 9305.5 9329.9 9391.5 7109.5 7122.4 7157.3 7224.7 7231.6 7658.2 7691.3 7717.7 7727.5 7756.8 6869.5 6963.4 7025.5 7039.2 7194.2 7033.4 7096.4 7115.7 7168.5 7185.2 6561.8 6751.6 6777.8 6778.7 6781.7 5024.8 5042.2 5162.5 5209.0 5234.5 5052.4 5073.5 5082.9 5157.7 5174.4 04:23:25 INFO - PROCESS | 18792 | 04:23:25 INFO - PROCESS | 18792 | [#4] prototype.html Cycles:180 Average:5549.42 Median:6322.90 stddev:1661.14 (26.3%) stddev-sans-first:1619.20 04:23:25 INFO - PROCESS | 18792 | Values: 343.8 353.8 354.8 355.3 355.5 6291.4 6296.7 6323.5 6362.7 6382.7 5876.6 6126.1 6216.2 6248.8 6300.1 4794.8 4836.6 4843.0 4843.0 4849.2 4828.7 4841.4 4857.0 4860.1 4860.9 4613.9 4672.4 4722.0 4725.8 4737.3 4707.5 4770.0 4773.4 4775.0 4796.4 4219.4 4226.7 4229.9 4233.4 4240.0 6008.8 6015.0 6027.2 6031.2 6047.3 5549.3 5556.0 5560.7 5569.5 5569.9 6416.7 6541.8 6553.7 6554.1 6554.3 4620.4 4644.9 4652.7 4653.8 4660.6 6844.3 6858.2 6873.0 6884.3 6898.9 4769.2 4771.7 4771.8 4779.7 4783.3 4840.0 4843.3 4845.0 4848.7 4849.1 5369.9 5462.5 5467.4 5542.4 5542.8 6563.3 6590.0 6593.3 6602.9 6608.1 1615.6 1659.3 1663.5 1703.2 1704.5 1110.6 1140.9 1142.4 1151.6 1154.2 6351.2 6366.1 6367.2 6376.7 6377.6 6772.6 6773.6 6776.6 6788.6 6804.6 6316.2 6318.9 6319.7 6322.3 6340.9 3614.5 3664.9 3666.9 3670.4 3671.3 6864.2 7029.3 7031.1 7035.9 7041.5 6874.5 6883.9 6888.8 6890.1 6902.9 6993.4 6997.4 7004.9 7011.6 7016.3 6712.1 6733.3 6745.0 6756.8 6764.7 6624.7 6657.6 6818.5 6826.0 6842.1 7148.9 7160.1 7201.5 7205.3 7209.5 4671.2 4720.5 4734.5 4735.6 4737.1 6629.4 6907.7 6915.4 6922.4 6932.4 6565.8 6701.6 6715.1 6732.6 6735.1 6613.3 6617.3 6631.5 6643.4 6667.6 6575.2 6603.9 6618.4 6620.8 6627.0 6588.6 6707.8 6711.2 6718.8 6734.8 6496.9 6533.1 6533.7 6538.2 6543.2 04:23:25 INFO - PROCESS | 18792 | 04:23:25 INFO - PROCESS | 18792 | [#5] yui.html Cycles:180 Average:15820.29 Median:24554.42 stddev:18228.84 (74.2%) stddev-sans-first:18245.16 04:23:25 INFO - PROCESS | 18792 | Values: 817.8 822.9 918.4 949.5 969.8 15478.1 15802.1 15842.0 15847.5 15867.0 14243.3 14311.2 14318.0 14334.3 14340.0 741.8 755.6 884.0 903.4 915.1 905.1 912.5 913.0 913.2 914.0 951.8 952.3 953.1 953.5 958.7 791.3 951.6 972.8 973.1 974.3 686.9 690.2 690.7 691.3 692.0 13460.3 13663.3 13674.1 13710.5 13720.2 14182.4 14329.6 14591.2 14955.8 15188.2 11856.6 11889.4 11898.1 12138.9 12151.9 4055.4 4066.5 4119.6 4129.8 4142.1 58144.0 58237.0 58241.1 58599.0 59723.0 11720.3 11807.6 11988.5 12055.8 12337.9 22147.8 22287.6 22312.6 22784.7 22908.3 8882.3 8953.2 8956.5 8974.1 9003.4 4957.0 5032.4 5069.2 5137.8 5144.5 3553.4 3609.5 3611.7 3615.3 3617.3 595.8 623.9 643.3 707.2 707.3 651.9 723.6 744.2 777.2 803.9 9158.2 9798.8 9864.6 9894.4 10026.3 561.3 581.3 662.1 680.9 698.0 4623.4 4686.8 4834.4 4938.9 4961.0 67353.7 67495.3 69493.0 69801.0 69882.7 55735.2 55978.7 56539.0 58743.4 58905.0 47486.5 47669.0 48879.3 49350.8 50458.0 10364.2 10557.4 10716.8 10848.2 10865.7 37696.2 38279.0 39057.6 39282.4 39301.6 44966.8 48425.8 50162.0 50407.7 51776.5 12611.5 12798.4 12839.0 12985.3 13220.3 12601.0 12905.6 13016.4 13164.6 13989.4 12983.4 13042.7 13090.7 13318.4 13407.1 13064.7 13167.2 13285.0 13452.1 13785.1 12917.9 13622.3 13916.2 14238.9 14349.6 11258.1 11383.3 11495.9 11508.0 11514.0 11271.7 11353.5 11525.2 11535.5 11767.3 04:23:25 INFO - PROCESS | 18792 | -------- Summary: end -------- 04:23:25 INFO - PROCESS | 18792 | 04:23:26 INFO - TEST-INFO | 18792: exit 0 04:23:26 INFO - TEST-OK | dromaeo_css | took 1112130ms 04:23:26 INFO - TEST-START | kraken 04:23:26 INFO - operating with platform_type : linux_ 04:23:26 INFO - Initialising browser for kraken test... 04:23:26 INFO - TEST-INFO | started process 18990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0tyASi/profile http://localhost:50451/getInfo.html) 04:23:30 INFO - PROCESS | 18990 | __metrics Screen width/height:1600/1200 04:23:30 INFO - PROCESS | 18990 | colorDepth:24 04:23:30 INFO - PROCESS | 18990 | Browser inner width/height: 1024/697 04:23:30 INFO - PROCESS | 18990 | __metrics 04:23:32 ERROR - PROCESS | 18990 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:23:32 INFO - TEST-INFO | 18990: exit 0 04:23:32 INFO - Browser initialized. 04:23:32 INFO - Running cycle 1/1 for kraken test... 04:23:32 INFO - TEST-INFO | started process 19082 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0tyASi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:44 INFO - PROCESS | 19082 | RSS: Main: 142483456 04:23:44 INFO - PROCESS | 19082 | 04:23:47 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50451/tests/kraken/driver.html?testName=audio-beat-detection) 04:23:48 INFO - PROCESS | 19082 | RSS: Main: 196788224 04:23:48 INFO - PROCESS | 19082 | 04:23:50 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50451/tests/kraken/driver.html?testName=audio-dft) 04:23:51 INFO - PROCESS | 19082 | RSS: Main: 182415360 04:23:51 INFO - PROCESS | 19082 | 04:23:54 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50451/tests/kraken/driver.html?testName=audio-fft) 04:23:54 INFO - PROCESS | 19082 | RSS: Main: 272740352 04:23:54 INFO - PROCESS | 19082 | 04:23:56 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50451/tests/kraken/driver.html?testName=audio-oscillator) 04:23:57 INFO - PROCESS | 19082 | RSS: Main: 178462720 04:23:57 INFO - PROCESS | 19082 | 04:23:59 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50451/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:24:00 INFO - PROCESS | 19082 | RSS: Main: 177635328 04:24:00 INFO - PROCESS | 19082 | 04:24:03 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50451/tests/kraken/driver.html?testName=imaging-darkroom) 04:24:03 INFO - PROCESS | 19082 | RSS: Main: 212086784 04:24:03 INFO - PROCESS | 19082 | 04:24:07 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50451/tests/kraken/driver.html?testName=imaging-desaturate) 04:24:07 INFO - PROCESS | 19082 | RSS: Main: 212680704 04:24:07 INFO - PROCESS | 19082 | 04:24:10 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50451/tests/kraken/driver.html?testName=json-parse-financial) 04:24:10 INFO - PROCESS | 19082 | RSS: Main: 211894272 04:24:10 INFO - PROCESS | 19082 | 04:24:12 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50451/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:24:13 INFO - PROCESS | 19082 | RSS: Main: 192237568 04:24:13 INFO - PROCESS | 19082 | 04:24:14 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50451/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:24:15 INFO - PROCESS | 19082 | RSS: Main: 195350528 04:24:15 INFO - PROCESS | 19082 | 04:24:17 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50451/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:24:18 INFO - PROCESS | 19082 | RSS: Main: 211505152 04:24:18 INFO - PROCESS | 19082 | 04:24:20 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:24:21 INFO - PROCESS | 19082 | RSS: Main: 214573056 04:24:21 INFO - PROCESS | 19082 | 04:24:23 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:24:24 INFO - PROCESS | 19082 | RSS: Main: 210345984 04:24:24 INFO - PROCESS | 19082 | 04:24:25 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:50451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50451/tests/kraken/driver.html?testName=ai-astar) 04:24:26 INFO - PROCESS | 19082 | RSS: Main: 274022400 04:24:26 INFO - PROCESS | 19082 | 04:24:26 INFO - PROCESS | 19082 | __start_tp_report 04:24:26 INFO - PROCESS | 19082 | _x_x_mozilla_page_load 04:24:26 INFO - PROCESS | 19082 | _x_x_mozilla_page_load_details 04:24:26 INFO - PROCESS | 19082 | |i|pagename|runs| 04:24:26 INFO - PROCESS | 19082 | |0;ai-astar;113;112;111;113;112;112;108;110;112;112 04:24:26 INFO - PROCESS | 19082 | |1;audio-beat-detection;149;126;152;170;127;155;151;127;189;133 04:24:26 INFO - PROCESS | 19082 | |2;audio-dft;161;161;162;159;161;160;162;160;162;161 04:24:26 INFO - PROCESS | 19082 | |3;audio-fft;76;77;77;167;77;77;76;76;156;77 04:24:26 INFO - PROCESS | 19082 | |4;audio-oscillator;91;92;154;92;93;93;148;93;92;154 04:24:26 INFO - PROCESS | 19082 | |5;imaging-gaussian-blur;117;117;117;118;116;117;117;116;118;118 04:24:26 INFO - PROCESS | 19082 | |6;imaging-darkroom;145;145;146;146;147;147;147;147;146;146 04:24:26 INFO - PROCESS | 19082 | |7;imaging-desaturate;94;95;94;94;94;96;95;95;95;94 04:24:26 INFO - PROCESS | 19082 | |8;json-parse-financial;53;54;54;52;54;54;55;82;54;53 04:24:26 INFO - PROCESS | 19082 | |9;json-stringify-tinderbox;57;58;57;57;58;58;58;58;57;57 04:24:26 INFO - PROCESS | 19082 | |10;stanford-crypto-aes;74;73;73;73;73;73;74;75;74;74 04:24:26 INFO - PROCESS | 19082 | |11;stanford-crypto-ccm;115;114;114;113;116;113;114;113;132;123 04:24:26 INFO - PROCESS | 19082 | |12;stanford-crypto-pbkdf2;158;154;155;154;164;159;166;161;157;162 04:24:26 INFO - PROCESS | 19082 | |13;stanford-crypto-sha256-iterative;73;66;65;66;65;66;71;66;68;63 04:24:26 INFO - PROCESS | 19082 | __end_tp_report 04:24:26 INFO - PROCESS | 19082 | __start_cc_report 04:24:26 INFO - PROCESS | 19082 | _x_x_mozilla_cycle_collect,1594 04:24:26 INFO - PROCESS | 19082 | __end_cc_report 04:24:26 INFO - PROCESS | 19082 | __startTimestamp1462965866202__endTimestamp 04:24:26 INFO - PROCESS | 19082 | 04:24:26 INFO - PROCESS | 19082 | ------- Summary: start ------- 04:24:26 INFO - PROCESS | 19082 | Number of tests: 14 04:24:26 INFO - PROCESS | 19082 | 04:24:26 INFO - PROCESS | 19082 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:1.51 (1.3%) stddev-sans-first:1.50 04:24:26 INFO - PROCESS | 19082 | Values: 113.0 112.0 111.0 113.0 112.0 112.0 108.0 110.0 112.0 112.0 04:24:26 INFO - PROCESS | 19082 | 04:24:26 INFO - PROCESS | 19082 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:151.50 stddev:20.63 (13.6%) stddev-sans-first:21.88 04:24:26 INFO - PROCESS | 19082 | Values: 149.0 126.0 152.0 170.0 127.0 155.0 151.0 127.0 189.0 133.0 04:24:26 INFO - PROCESS | 19082 | 04:24:26 INFO - PROCESS | 19082 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 04:24:26 INFO - PROCESS | 19082 | Values: 161.0 161.0 162.0 159.0 161.0 160.0 162.0 160.0 162.0 161.0 04:24:26 INFO - PROCESS | 19082 | 04:24:26 INFO - PROCESS | 19082 | [#3] audio-fft Cycles:10 Average:93.60 Median:77.00 stddev:35.88 (46.6%) stddev-sans-first:37.49 04:24:26 INFO - PROCESS | 19082 | Values: 76.0 77.0 77.0 167.0 77.0 77.0 76.0 76.0 156.0 77.0 04:24:26 INFO - PROCESS | 19082 | 04:24:26 INFO - PROCESS | 19082 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:92.00 stddev:28.90 (31.4%) stddev-sans-first:29.80 04:24:26 INFO - PROCESS | 19082 | Values: 91.0 92.0 154.0 92.0 93.0 93.0 148.0 93.0 92.0 154.0 04:24:26 INFO - PROCESS | 19082 | 04:24:26 INFO - PROCESS | 19082 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 04:24:26 INFO - PROCESS | 19082 | Values: 117.0 117.0 117.0 118.0 116.0 117.0 117.0 116.0 118.0 118.0 04:24:26 INFO - PROCESS | 19082 | 04:24:26 INFO - PROCESS | 19082 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.71 04:24:26 INFO - PROCESS | 19082 | Values: 145.0 145.0 146.0 146.0 147.0 147.0 147.0 147.0 146.0 146.0 04:24:26 INFO - PROCESS | 19082 | 04:24:26 INFO - PROCESS | 19082 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 04:24:26 INFO - PROCESS | 19082 | Values: 94.0 95.0 94.0 94.0 94.0 96.0 95.0 95.0 95.0 94.0 04:24:26 INFO - PROCESS | 19082 | 04:24:26 INFO - PROCESS | 19082 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:54.00 stddev:9.00 (16.7%) stddev-sans-first:9.45 04:24:26 INFO - PROCESS | 19082 | Values: 53.0 54.0 54.0 52.0 54.0 54.0 55.0 82.0 54.0 53.0 04:24:26 INFO - PROCESS | 19082 | 04:24:26 INFO - PROCESS | 19082 | [#9] json-stringify-tinderbox Cycles:10 Average:57.50 Median:58.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 04:24:26 INFO - PROCESS | 19082 | Values: 57.0 58.0 57.0 57.0 58.0 58.0 58.0 58.0 57.0 57.0 04:24:26 INFO - PROCESS | 19082 | 04:24:26 INFO - PROCESS | 19082 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:74.00 stddev:0.70 (0.9%) stddev-sans-first:0.73 04:24:26 INFO - PROCESS | 19082 | Values: 74.0 73.0 73.0 73.0 73.0 73.0 74.0 75.0 74.0 74.0 04:24:26 INFO - PROCESS | 19082 | 04:24:26 INFO - PROCESS | 19082 | [#11] stanford-crypto-ccm Cycles:10 Average:116.70 Median:114.50 stddev:6.15 (5.4%) stddev-sans-first:6.49 04:24:26 INFO - PROCESS | 19082 | Values: 115.0 114.0 114.0 113.0 116.0 113.0 114.0 113.0 132.0 123.0 04:24:26 INFO - PROCESS | 19082 | 04:24:26 INFO - PROCESS | 19082 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.00 Median:160.00 stddev:4.19 (2.6%) stddev-sans-first:4.43 04:24:26 INFO - PROCESS | 19082 | Values: 158.0 154.0 155.0 154.0 164.0 159.0 166.0 161.0 157.0 162.0 04:24:26 INFO - PROCESS | 19082 | 04:24:26 INFO - PROCESS | 19082 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.00 stddev:3.00 (4.5%) stddev-sans-first:2.22 04:24:26 INFO - PROCESS | 19082 | Values: 73.0 66.0 65.0 66.0 65.0 66.0 71.0 66.0 68.0 63.0 04:24:26 INFO - PROCESS | 19082 | -------- Summary: end -------- 04:24:26 INFO - PROCESS | 19082 | 04:24:27 INFO - TEST-INFO | 19082: exit 0 04:24:27 INFO - TEST-OK | kraken | took 60509ms 04:24:27 INFO - SUITE-END | took 1172s 04:24:27 INFO - Completed test suite (00:19:32) 04:24:27 INFO - javascript benchmark 04:24:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3247.3829972305266, 3310.3710295043948, 3339.0, 3363.041533163046, 3380.9661903380957, 5482.259894914186, 5493.862653433661, 5495.999999999995, 5502.312210973629, 5510.779568817243, 5481.835544933659, 5521.613487055908, 5523.28197334346, 5530.6128570999945, 5559.777608895639, 4929.137400954819, 4982.750862456881, 5073.0, 5130.256112863633, 5153.252778347156, 4986.95273992462, 5034.119029169899, 5080.187170052793, 5081.98360327934, 5086.821961231358, 4997.275395067713, 5039.874003149932, 5062.898742025157, 5069.0, 5075.9492405076035, 5076.517730815566, 5100.413452452941, 5120.92318615221, 5122.949795291956, 5148.2020286855595, 4858.02839432115, 4951.653384263103, 5022.196448568212, 5023.748812559394, 5052.747362631853, 5417.295751552273, 5417.485338892799, 5448.809291674812, 5465.480779325958, 5477.0, 5874.441928016831, 5921.73352199152, 5930.140129681172, 5932.288125424977, 5932.644041357532, 5889.528837692974, 5954.047352423591, 5958.731857066442, 6012.0, 6018.96990515049, 5503.7798488060425, 5507.807226747044, 5508.531774799147, 5540.750666220029, 5542.168674698787, 5970.582059255898, 6057.3336932937345, 6070.878582428327, 6073.18012068374, 6079.513638908877, 5856.238688970492, 5898.997170481029, 5904.645721256738, 5905.704714764244, 5908.675022873697, 5892.616979896293, 5899.734511946973, 5899.793507227227, 5905.911411328833, 5921.5558833086825, 5744.540436765133, 5841.620294680833, 5867.647941123546, 5870.73581688825, 5876.529877609781, 5915.58590898633, 5943.5839491236065, 5945.316288626776, 5951.1073338999495, 5988.640681559121, 4502.189605870974, 4515.75163366018, 4517.954820451753, 4521.253993091103, 4545.636349092131, 3957.050307926077, 4003.0, 4057.533383660858, 4057.9797101014897, 4107.424960505532, 5495.450454954553, 5514.779408823602, 5518.392976772552, 5520.309961254843, 5528.917066244009, 5844.532437404998, 5869.618474799125, 5875.089361149029, 5875.941240587625, 5882.705864706748, 5411.215373770781, 5542.11326187808, 5586.301712285965, 5657.264555607827, 5675.063614503643, 4678.485366609671, 4683.765811709401, 4686.367340409001, 4695.201815691341, 4716.3868697069165, 6075.422834830684, 6084.330723620398, 6086.421789929949, 6089.269287685417, 6102.450779429784, 5820.592558520862, 5916.73374698131, 5974.581779275409, 5987.221661184192, 6009.098635204754, 6165.599236049642, 6170.290416602148, 6184.907226391698, 6188.226471691039, 6196.225471816023, 5689.1750696148, 5826.679532625746, 5834.212381328466, 5834.416558344132, 5838.824835254949, 5863.618864773776, 5909.143174239625, 5932.288125424977, 5939.227900372924, 5959.1657167995645, 5737.454941780524, 5750.367459579526, 5751.1373294006235, 5755.827325180251, 5760.222369980167, 5497.065498865122, 5736.4550367716665, 5737.196792449144, 5744.167095771007, 5767.279090113736, 5693.259876216065, 5694.0, 5697.7151142443545, 5702.543796496353, 5731.799387021434, 5796.42035796417, 5803.680797556175, 5830.679312637845, 5833.82498525045, 5838.591298609226, 5559.0, 5664.433556644302, 5704.657720536781, 5737.8565535861935, 5737.942620573908], "value": 5440.74711427756, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.3462572053666, 669.477807310298, 680.4454369688704, 682.2699711308901, 759.2255898983034, 33177.502337464924, 39369.80315098424, 40223.79888100563, 40279.0, 40296.79851600738, 42726.786366068125, 43453.0, 43886.78056609721, 43899.3415098773, 44059.55940440595, 8036.959815200945, 8899.599518021689, 9103.180713735763, 10460.058594726474, 10656.360618362884, 10519.421431821247, 10628.57485700575, 10661.78676426471, 10663.14694824416, 10664.893351066507, 10651.0, 10672.35965842048, 10727.08819750322, 10740.78518429631, 10742.946285268563, 8285.50286982783, 10502.159827213844, 10681.946590266998, 10687.465626718711, 10720.839187412195, 10675.252732308742, 10832.40421776802, 10843.457827108692, 10849.132069434427, 10850.403227822466, 39984.400233996515, 40420.1915961682, 40544.594554054675, 40571.188576228604, 40587.391189132184, 3707.29561383339, 3743.737938344317, 3807.8667246646232, 3819.4843696100947, 3877.651011408987, 33476.16309592255, 33952.49071263933, 34061.48907766386, 34182.658173418444, 34208.65791342079, 4514.616257618107, 4556.430446194226, 4590.449146102489, 4594.264917613166, 4630.675852690313, 309474.0, 311139.0, 311659.0, 311761.0, 311826.0, 40246.79876600657, 68132.3186768136, 69371.0, 69409.0, 69443.65278173678, 39008.60991390106, 39302.266284702906, 39394.212115757524, 39484.210315794095, 39521.20957580832, 16246.75629865553, 16881.66236675284, 17108.657826843395, 17111.486655400357, 17124.315027398763, 13888.930555347159, 14301.499447519494, 14302.070365426214, 14320.713585728436, 14330.283485825876, 9442.10300021497, 9491.525423728925, 9491.810163796685, 9524.523773811281, 9551.61793528265, 3655.8903232903053, 3825.0437390652337, 3825.598312177237, 3829.4447305140598, 3834.328992426314, 1100.526773487408, 1139.4758411130972, 1160.8665003524534, 1179.5753528729651, 1237.6101528018646, 33187.66812331894, 33520.16199595029, 33805.49291760626, 33855.0, 34024.31951360959, 1217.9264479626816, 1251.3492983648453, 1277.240042174923, 1284.9614511564669, 1390.2840037380756, 17845.616660431475, 18007.549811254823, 18047.2640510065, 18093.0, 18118.818811811976, 447778.0, 513564.0, 521589.0, 522070.0, 522351.0, 61496.69251653802, 62068.0, 62068.689656552335, 62302.37697623057, 62603.0, 1449.0436312034008, 1534.1178822177292, 1558.7428074367829, 1567.9608009799617, 1629.6577718678973, 30978.380432390775, 33773.66226337705, 33811.15472113217, 33838.32323353568, 34553.136171595914, 51014.0, 51565.22652160146, 51579.0, 51659.2251116226, 51707.48292517027, 341893.0, 343930.0, 344211.0, 344702.0, 344895.0, 27740.861295694198, 30966.53550196704, 31840.203994900312, 31934.0, 31951.36097277995, 47310.0, 51722.0, 51940.0, 52048.479515204366, 52511.47488525066, 37227.255454891296, 37369.813150934075, 37608.0, 37741.81129094337, 38003.0, 36986.44520332143, 37780.2443951114, 38146.0, 38215.80892095522, 38690.613093869826, 39659.60340396559, 39819.60180398275, 45523.77238113788, 46482.767586161855, 46842.0, 32619.0, 33842.32315353728, 34106.0, 34157.829210853786, 34483.65516344804, 27998.440031198854, 29195.562066569444, 29248.26879328034, 29343.85328073346, 29492.852535737184], "value": 19883.504569705103, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.72100413726935, 437.949635791884, 440.86553601151655, 440.9911801763965, 442.7166613367443, 18179.36372226972, 18359.632807343845, 18466.722999155023, 19124.713129303054, 20068.0, 19461.902690486564, 19484.3438307744, 19919.0, 19958.60082798343, 19969.900150499263, 5649.887002259952, 5663.5186009189165, 5813.389594092623, 5817.505512031483, 5818.185454036438, 5733.48398644122, 5799.391063938289, 5809.215755872967, 5815.098659707752, 5836.9124463133085, 5676.2620859288445, 5688.579451091484, 5790.10253410722, 5828.271466066742, 5838.824835254928, 5657.688827114507, 5663.8584035399035, 5671.914921276184, 5676.517496012844, 5686.715664216773, 5155.484451554852, 5160.7419629018395, 5451.618386712932, 5715.199872017879, 5719.59962802604, 13371.465141394332, 13537.39081741324, 13653.180809151383, 13769.380377883019, 13901.304934753221, 2396.161343529768, 2408.1812183857573, 2470.0, 2498.912538061177, 2599.7270286619823, 10022.448765317904, 10157.898421015769, 10274.7431314217, 10536.525856336484, 10626.203034772423, 1945.503896506396, 1951.9219231230734, 2019.2730616977876, 2061.402193363923, 2111.915523379063, 77743.0, 84997.57501212516, 85554.57222713971, 85681.0, 85847.0, 11032.172587056002, 11384.0, 11411.315321080761, 11508.251963622337, 11633.6509904703, 16124.0, 16142.950708203929, 16318.265678044516, 16415.83584164143, 16459.177041147894, 8879.0, 8896.8665470018, 8950.328725345495, 8976.640934362553, 9016.18854303116, 8791.0, 8809.823803524021, 8886.4668119913, 8896.73309800694, 8972.685955991508, 4947.82682606107, 4994.0, 5013.5989120870245, 5014.6991180529285, 5046.697198168122, 1787.767590213264, 2029.1680411031407, 2094.654382026979, 2128.936131916045, 2159.9460013499474, 473.5974421741492, 510.6093838213769, 954.0745476887408, 1010.686687126993, 1212.1151559361715, 11613.535458581562, 11837.76324473523, 11854.822177667342, 11879.168458208016, 11946.163768536118, 471.6839717389357, 506.6124414822664, 507.9441261461236, 516.4499807704857, 520.5601266929439, 5940.168376427304, 6479.092926990225, 6517.315681853337, 6554.508411869034, 6556.082148499214, 560282.0, 562048.0, 562955.0, 573497.0, 573917.0, 95644.0, 98900.0, 101474.49262753638, 101812.0, 102753.0, 518.3520599251011, 521.7443452708146, 525.4115390762371, 526.4209369693383, 527.575301881981, 11144.2199046066, 11327.603533876274, 11370.602028928948, 11416.372099534274, 11443.42782860837, 37894.0, 39281.0, 39571.0, 39900.40149397819, 39946.20107597773, 51955.0, 56549.0, 58028.4197158023, 58132.4186758127, 58787.412125878196, 8881.555922203735, 8938.68714594986, 9054.094590540893, 9109.498977556297, 9139.634414623606, 12773.425195866022, 13166.473341066634, 13453.0, 13470.787629113427, 13622.386992585556, 11479.540818367172, 11512.481938312629, 11761.47073381717, 12221.144519883523, 12369.814452783035, 11263.549458021587, 11672.47473863695, 11864.22882512634, 11881.22772019816, 11950.880491194977, 11870.228435152034, 12137.69655758613, 12214.328211948428, 12215.938920305342, 12307.20003199789, 8483.957580212307, 8660.740177794676, 8823.69117080899, 8953.955230223808, 9029.006809251108, 9235.953820230856, 11580.826287605862, 11612.187146899636, 11685.182037257651, 11947.641570752892], "value": 8585.687553658609, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.3968403112708, 1580.5100418870152, 1583.2056420417957, 1755.5786611213305, 1873.8969356685377, 7769.611519424027, 7984.640691168896, 7988.400869934756, 7991.120976692574, 8004.439689221756, 7797.220277972214, 7955.0453945526615, 7964.362850971923, 7976.242256985592, 7976.641051152697, 2062.711220429141, 2299.4366380236866, 2338.918137865175, 2367.1005018093188, 2370.4073981504625, 2367.8105751539833, 2403.291029146406, 2407.927762167129, 2408.5664580375524, 2409.277216834951, 2194.7585765565773, 2241.9215327463544, 2243.1363924888874, 2243.5288589396246, 2248.651459023854, 2113.6301147299237, 2240.2383189715492, 2282.931512054641, 2283.942901427469, 2286.7141607299086, 2225.8441909066373, 2259.4803195265017, 2261.366817291161, 2276.3512398966213, 2278.7721227877246, 7543.547387156733, 7587.772366829004, 7598.0, 7620.276073772982, 7622.199669034782, 5009.624278179152, 5117.181250999822, 5121.974390128025, 5123.2827404163445, 5205.661631993946, 3340.916477088092, 3355.261842394669, 3398.490226466025, 3405.0465869556315, 3434.845431955568, 1135.9716007099805, 1200.3938011304322, 1205.3310412720937, 1222.3888055972013, 1282.1729984160258, 10474.79050418995, 10565.788684226349, 10585.523651435704, 10606.734831629194, 10622.25644204906, 4307.956920430818, 4369.300911854151, 4385.824567017347, 4401.141777353385, 4403.559644035571, 9227.169554740105, 9229.307801914749, 9234.307426943005, 9271.67549135777, 9274.768130796783, 4592.334111553872, 4995.675281106789, 4999.125153098194, 4999.825006124768, 5006.69959802413, 4664.440267167962, 4677.2750223715375, 4721.693089949143, 4723.244280915037, 4749.762511874393, 3923.156521347924, 3976.1252524444576, 4006.399040144002, 4045.8583949561626, 4067.2068946555137, 1291.2639795316768, 1314.7107636320186, 1329.5878277733934, 1335.819664345301, 1341.6578772413168, 1023.3910823060268, 1076.4779082145153, 1083.669480808361, 1093.1965005720788, 1102.685734565661, 5940.881182376328, 6000.969995149996, 6009.669468179292, 6117.755289788359, 6134.601250918676, 492.07489918952143, 493.437481271351, 495.00503986986416, 495.1928356778428, 497.7138145566314, 4171.749695018309, 4179.477565304337, 4192.3711443283755, 4199.118185181085, 4278.893027674333, 9595.808083838285, 9985.350952188084, 9990.050945160343, 10017.749556261006, 10018.448985305733, 9901.207903367713, 9911.752206194758, 9925.702228933143, 9940.453275069796, 9947.850782238273, 7458.813529661802, 7601.885971710429, 7698.384129269645, 7702.0, 7716.5370077795515, 5550.167474878801, 5657.60396772222, 5767.163761254678, 5771.653700777967, 5793.275840519935, 8797.384183107377, 8944.195022448012, 9054.547272636473, 9194.632214711337, 9236.907630923874, 9293.953530232306, 9300.20948219409, 9305.488198149167, 9329.906700933176, 9391.483468409304, 7109.537880037781, 7122.394596459152, 7157.320054594805, 7224.711011559479, 7231.63841807918, 7658.234176582298, 7691.269329413697, 7717.6527056281475, 7727.459077864495, 7756.806079848049, 6869.519133660596, 6963.442924566124, 7025.508214424941, 7039.155301363664, 7194.172670143001, 7033.402160816183, 7096.361327480345, 7115.715371385294, 7168.498205125799, 7185.173705023989, 6561.80314590563, 6751.628660423724, 6777.830554236183, 6778.694958726771, 6781.728730850711, 5024.84925452237, 5042.243663450512, 5162.483751624807, 5209.0, 5234.476552344888, 5052.444231134646, 5073.518015788494, 5082.898342033065, 5157.735362009601, 5174.379074511083], "value": 4384.9334025710605, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.7765452455905, 353.8354665080737, 354.7676272041813, 355.3213362477668, 355.539576248758, 6291.370862913712, 6296.748130074797, 6323.462505687016, 6362.745490180388, 6382.712777924993, 5876.618019828708, 6126.050462178358, 6216.191895053648, 6248.84377890553, 6300.05499175124, 4794.808207671689, 4836.564709176174, 4842.999999999983, 4843.031393721243, 4849.175640141185, 4828.686135401205, 4841.443234028096, 4857.0, 4860.1008813369635, 4860.902781944359, 4613.861584152464, 4672.4393072831135, 4722.0, 4725.763711814413, 4737.289406589022, 4707.482176960531, 4770.045990801819, 4773.355596994396, 4774.952250477503, 4796.400449943757, 4219.409282700424, 4226.661867050629, 4229.873103806891, 4233.428487154226, 4240.0, 6008.8497787555225, 6015.0, 6027.246594175728, 6031.155638210654, 6047.274327080734, 5549.250851135085, 5556.0, 5560.7219639017885, 5569.526590239834, 5569.944300556983, 6416.743330266784, 6541.836454088639, 6553.705083271217, 6554.082428460019, 6554.311797261266, 4620.399348084761, 4644.930326045112, 4652.651051171142, 4653.837115700934, 4660.557247061523, 6844.349786770299, 6858.177018757731, 6872.965635171842, 6884.345987131214, 6898.862022759567, 4769.2130798417875, 4771.71369717818, 4771.809127634856, 4779.713217206979, 4783.306420569068, 4840.031993601294, 4843.329051477234, 4845.0, 4848.7090774552935, 4849.102915960488, 5369.865753356197, 5462.481064298885, 5467.425920278393, 5542.3903370630005, 5542.806001789918, 6563.310852360529, 6589.967050164814, 6593.274739778621, 6602.900956485657, 6608.107905432801, 1615.579949213213, 1659.2533359988054, 1663.534210421084, 1703.1824724132487, 1704.4630941253465, 1110.5724296146043, 1140.8516892803882, 1142.4459137318395, 1151.6026970695098, 1154.1516985016005, 6351.237851457762, 6366.076918846741, 6367.2040994874715, 6376.7130479128555, 6377.649229292433, 6772.55978361405, 6773.62745049027, 6776.559523630948, 6788.558743681645, 6804.591724496546, 6316.178896743394, 6318.873622527615, 6319.652419116993, 6322.336154703782, 6340.873182536416, 3614.530111085542, 3664.88221092564, 3666.8533258669886, 3670.4127339625534, 3671.284099600552, 6864.176298844171, 7029.297070293032, 7031.1211098612675, 7035.859282814315, 7041.507094503438, 6874.450043996469, 6883.862322753517, 6888.827779305458, 6890.069840571458, 6902.93097069033, 6993.440524758007, 6997.440204783605, 7004.929950700428, 7011.579305241804, 7016.333448322402, 6712.060311556484, 6733.326667333227, 6745.0, 6756.831079223059, 6764.729410823512, 6624.701888415129, 6657.600543967377, 6818.454523638196, 6825.965870170618, 6842.110525631636, 7148.857022859618, 7160.10498687664, 7201.459890508128, 7205.315495027964, 7209.531380460463, 4671.205894997791, 4720.5043470436485, 4734.479207287264, 4735.59747421473, 4737.07627012743, 6629.370209830058, 6907.654617269016, 6915.412189963708, 6922.446204303745, 6932.376086152271, 6565.835854103686, 6701.597904125768, 6715.059891615276, 6732.562383445061, 6735.1244338237675, 6613.27254002069, 6617.305182955721, 6631.535792494672, 6643.435307998874, 6667.566608170453, 6575.24384695747, 6603.900941485786, 6618.404343609098, 6620.801375958729, 6627.0, 6588.571742836701, 6707.832304192434, 6711.194656641234, 6718.798436046926, 6734.831629209309, 6496.870062598627, 6533.118029066015, 6533.738650453929, 6538.248101468392, 6543.247526534509], "value": 5009.08245362554, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [817.7996390884234, 822.9012518497777, 918.386575290839, 949.45406391325, 969.8205831921096, 15478.148701821396, 15802.13088280144, 15842.049477031373, 15847.524574262761, 15867.0, 14243.287835608204, 14311.212883291415, 14318.0, 14334.283285835692, 14340.0, 741.7737590035038, 755.5655498088594, 883.9690610828623, 903.408267584733, 915.0620613870769, 905.0632595263903, 912.543728135932, 912.9817403651923, 913.2009491694768, 913.968011119611, 951.7668171298008, 952.2953014769056, 953.1231267234161, 953.5232383808096, 958.7411398922287, 791.3234184772024, 951.5527701980059, 972.7568107973007, 973.0512750068697, 974.2644303550774, 686.8694947959922, 690.1717938473802, 690.6546726636682, 691.2776148924386, 692.0207905813268, 13460.326983650779, 13663.316834158253, 13674.111182773187, 13710.45158193671, 13720.176789392668, 14182.361793719307, 14329.570112896525, 14591.197484138474, 14955.775663365059, 15188.240587970668, 11856.644300670907, 11889.405529723479, 11898.107641926803, 12138.939305303506, 12151.939240303831, 4055.371417430303, 4066.5120185577625, 4119.629233369011, 4129.834806607732, 4142.06803469217, 58144.0, 58237.0, 58241.12638310387, 58599.0, 59723.0, 11720.296782193096, 11807.645770626896, 11988.546417281632, 12055.819162712567, 12337.876621233672, 22147.778522214892, 22287.55424891493, 22312.553748925257, 22784.658230126563, 22908.312750617508, 8882.289416846637, 8953.194212520904, 8956.462612243286, 8974.102589740975, 9003.414778039538, 4957.0, 5032.3961124665275, 5069.188929771219, 5137.768800403916, 5144.536991670768, 3553.3959226931483, 3609.5488063992, 3611.747177697536, 3615.349237137288, 3617.330793803155, 595.8033848829875, 623.9438450539474, 643.2827397451807, 707.2043950555625, 707.3033062433499, 651.8989556618732, 723.5767076260447, 744.1888341707564, 777.2227772227773, 803.9035315762029, 9158.175764181256, 9798.75503112428, 9864.556094975744, 9894.356866803779, 10026.348287361297, 561.2899681902396, 581.2501872584319, 662.0929326822188, 680.883351303862, 697.9651017449107, 4623.445186577632, 4686.759430644053, 4834.419869615598, 4938.925916111261, 4960.950390496121, 67353.66323168353, 67495.32504674989, 69493.0, 69801.0, 69882.65058674673, 55735.163972540446, 55978.72010639921, 56539.0, 58743.41256587465, 58905.0, 47486.5251347489, 47669.0, 48879.26681099786, 49350.75324623426, 50458.0, 10364.222683298633, 10557.366558006544, 10716.839247411452, 10848.240623156304, 10865.674029779118, 37696.246075078896, 38279.0, 39057.609423906535, 39282.410763839136, 39301.60698392979, 44966.77516612396, 48425.757871210415, 50162.0, 50407.747961259956, 51776.482235177165, 12611.495540178657, 12798.360081995677, 12839.037072219808, 12985.28580928058, 13220.272884991418, 12601.0, 12905.612831615066, 13016.414261358452, 13164.60506184816, 13989.370478328703, 12983.41574629125, 13042.739145217232, 13090.672733181747, 13318.400671969592, 13407.128536645087, 13064.738705225653, 13167.209967401986, 13285.0, 13452.1256118352, 13785.103968242032, 12917.870821291666, 13622.250776207404, 13916.165030098227, 14238.928805355907, 14349.64125896861, 11258.09935205198, 11383.260088094248, 11495.885041149482, 11508.0, 11514.0, 11271.718207044889, 11353.545858165911, 11525.193236473702, 11535.480903359201, 11767.293962362286], "value": 7202.624125010092, "unit": "score"}], "name": "dromaeo_css", "value": 7264.34301920659, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 111.0, 113.0, 112.0, 112.0, 108.0, 110.0, 112.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 152.0, 170.0, 127.0, 155.0, 151.0, 127.0, 189.0, 133.0], "value": 147.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 159.0, 161.0, 160.0, 162.0, 160.0, 162.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 167.0, 77.0, 77.0, 76.0, 76.0, 156.0, 77.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 154.0, 92.0, 93.0, 93.0, 148.0, 93.0, 92.0, 154.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 116.0, 118.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 96.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 52.0, 54.0, 54.0, 55.0, 82.0, 54.0, 53.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 57.0, 58.0, 58.0, 58.0, 58.0, 57.0, 57.0], "value": 57.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 73.0, 73.0, 73.0, 74.0, 75.0, 74.0, 74.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 113.0, 116.0, 113.0, 114.0, 113.0, 132.0, 123.0], "value": 116.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 154.0, 155.0, 154.0, 164.0, 159.0, 166.0, 161.0, 157.0, 162.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 66.0, 65.0, 66.0, 65.0, 66.0, 71.0, 66.0, 68.0, 63.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1512.2, "alertThreshold": 2.0}]} 04:24:27 INFO - Return code: 0 04:24:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:24:27 ERROR - # TBPL SUCCESS # 04:24:27 INFO - Running post-action listener: _resource_record_post_action 04:24:27 INFO - Running post-run listener: _resource_record_post_run 04:24:28 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 497819648; Read time: 44; Write time: 1111276 04:24:28 INFO - install - Wall time: 16s; CPU: 18.0%; Read bytes: 0; Write bytes: 250265600; Read time: 0; Write time: 731776 04:24:28 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 247554048; Read time: 44; Write time: 379500 04:24:28 INFO - Running post-run listener: _upload_blobber_files 04:24:28 INFO - Blob upload gear active. 04:24:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:24:28 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:24:28 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:24:28 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:24:28 INFO - (blobuploader) - INFO - Open directory for files ... 04:24:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:24:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:24:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:24:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:24:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:24:29 INFO - (blobuploader) - INFO - Done attempting. 04:24:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:24:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:24:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:24:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:24:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:24:30 INFO - (blobuploader) - INFO - Done attempting. 04:24:30 INFO - (blobuploader) - INFO - Iteration through files over. 04:24:30 INFO - Return code: 0 04:24:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:24:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:24:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc3c60aa84a0b5ebc6091b828acc4e9249a3a7ac2835fd10bb33c2691c608ba6faa85ba338d66a12f74bcb2390eff6426ee6d9d1254325c0e983cd4c1caec2cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb6edc8889dd9e2e11b6dd35233437445a4b6f176fb228598255622c7465136e73661d014e3a7a54e37e63eca27352fac2e8c251d08055250a84e1b91c4ca60e"} 04:24:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:24:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:24:30 INFO - Contents: 04:24:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc3c60aa84a0b5ebc6091b828acc4e9249a3a7ac2835fd10bb33c2691c608ba6faa85ba338d66a12f74bcb2390eff6426ee6d9d1254325c0e983cd4c1caec2cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb6edc8889dd9e2e11b6dd35233437445a4b6f176fb228598255622c7465136e73661d014e3a7a54e37e63eca27352fac2e8c251d08055250a84e1b91c4ca60e"} 04:24:30 INFO - Running post-run listener: copy_logs_to_upload_dir 04:24:30 INFO - Copying logs to upload dir... 04:24:30 INFO - mkdir: /builds/slave/test/build/upload/logs 04:24:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.585611 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-11 04:24:30.384847) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 04:24:30.388555) ========= 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=af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274 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/cc3c60aa84a0b5ebc6091b828acc4e9249a3a7ac2835fd10bb33c2691c608ba6faa85ba338d66a12f74bcb2390eff6426ee6d9d1254325c0e983cd4c1caec2cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb6edc8889dd9e2e11b6dd35233437445a4b6f176fb228598255622c7465136e73661d014e3a7a54e37e63eca27352fac2e8c251d08055250a84e1b91c4ca60e"} 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.011213 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/cc3c60aa84a0b5ebc6091b828acc4e9249a3a7ac2835fd10bb33c2691c608ba6faa85ba338d66a12f74bcb2390eff6426ee6d9d1254325c0e983cd4c1caec2cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb6edc8889dd9e2e11b6dd35233437445a4b6f176fb228598255622c7465136e73661d014e3a7a54e37e63eca27352fac2e8c251d08055250a84e1b91c4ca60e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 04:24:30.420267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:24:30.420881) ========= 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=af724c981e2a0f424dbabf99000001e7-1462964639.578809-1190302274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:24:30.505394) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 04:24:30.505968) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 04:24:30.506547) ========= ========= Total master_lag: 0.19 =========