builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1462616793.05 results: success (0) buildid: 20160507004025 builduid: ddaa3fd3500e4c1d9188a80972a92b54 revision: ddb972fb7c3721d82fb05774bbaf41806f13e545 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-07 03:26:33.052273) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-07 03:26:33.052736) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-07 03:26:33.053004) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-07 03:26:33.081528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 03:26:33.081865) ========= 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=00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-07 03:26:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.2M=0s 2016-05-07 03:26:33 (40.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139984 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 03:26:33.243541) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 03:26:33.243845) ========= 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=00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020688 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 03:26:33.293293) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 03:26:33.293656) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ddb972fb7c3721d82fb05774bbaf41806f13e545 --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 ddb972fb7c3721d82fb05774bbaf41806f13e545 --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=00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-07 03:26:33,622 truncating revision to first 12 chars 2016-05-07 03:26:33,622 Setting DEBUG logging. 2016-05-07 03:26:33,622 attempt 1/10 2016-05-07 03:26:33,622 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ddb972fb7c37?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-07 03:26:33,877 unpacking tar archive at: mozilla-aurora-ddb972fb7c37/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531861 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 03:26:33.841269) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-07 03:26:33.841580) ========= script_repo_revision: ddb972fb7c3721d82fb05774bbaf41806f13e545 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-07 03:26:33.842151) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-07 03:26:33.842460) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-07 03:26:33.860530) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-07 03:26:33.860902) ========= /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=00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:26:34 INFO - MultiFileLogger online at 20160507 03:26:34 in /builds/slave/test 03:26:34 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 03:26:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:26:34 INFO - {'append_to_log': False, 03:26:34 INFO - 'base_work_dir': '/builds/slave/test', 03:26:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:26:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:26:34 INFO - 'branch': 'Mozilla-Aurora', 03:26:34 INFO - 'buildbot_json_path': 'buildprops.json', 03:26:34 INFO - 'config_files': ('talos/linux_config.py',), 03:26:34 INFO - 'default_actions': ('clobber', 03:26:34 INFO - 'read-buildbot-config', 03:26:34 INFO - 'download-and-extract', 03:26:34 INFO - 'populate-webroot', 03:26:34 INFO - 'create-virtualenv', 03:26:34 INFO - 'install', 03:26:34 INFO - 'run-tests'), 03:26:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:26:34 INFO - 'download_minidump_stackwalk': True, 03:26:34 INFO - 'download_symbols': 'ondemand', 03:26:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:26:34 INFO - 'tooltool.py': '/tools/tooltool.py', 03:26:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:26:34 INFO - '/tools/misc-python/virtualenv.py')}, 03:26:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:26:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:26:34 INFO - 'installer_path': 'installer.exe', 03:26:34 INFO - 'log_level': 'info', 03:26:34 INFO - 'log_name': 'talos', 03:26:34 INFO - 'log_to_console': True, 03:26:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:26:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:26:34 INFO - 'opt_config_files': (), 03:26:34 INFO - 'pip_index': False, 03:26:34 INFO - 'sps_profile': False, 03:26:34 INFO - 'sps_profile_interval': 0, 03:26:34 INFO - 'suite': 'dromaeojs', 03:26:34 INFO - 'system_bits': '32', 03:26:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:26:34 INFO - 'title': 'talos-linux64-ix-016', 03:26:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:26:34 INFO - 'use_talos_json': True, 03:26:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:26:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:26:34 INFO - 'work_dir': 'build'} 03:26:34 INFO - ##### 03:26:34 INFO - ##### Running clobber step. 03:26:34 INFO - ##### 03:26:34 INFO - Running pre-action listener: _resource_record_pre_action 03:26:34 INFO - Running main action method: clobber 03:26:34 INFO - rmtree: /builds/slave/test/build 03:26:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:26:35 INFO - Running post-action listener: _resource_record_post_action 03:26:35 INFO - ##### 03:26:35 INFO - ##### Running read-buildbot-config step. 03:26:35 INFO - ##### 03:26:35 INFO - Running pre-action listener: _resource_record_pre_action 03:26:35 INFO - Running main action method: read_buildbot_config 03:26:35 INFO - Using buildbot properties: 03:26:35 INFO - { 03:26:35 INFO - "project": "", 03:26:35 INFO - "product": "firefox", 03:26:35 INFO - "script_repo_revision": "production", 03:26:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:26:35 INFO - "repository": "", 03:26:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:26:35 INFO - "buildid": "20160507004025", 03:26:35 INFO - "stage_platform": "linux64-pgo", 03:26:35 INFO - "basedir": "/builds/slave/test", 03:26:35 INFO - "nightly_build": "True", 03:26:35 INFO - "buildnumber": 313, 03:26:35 INFO - "slavename": "talos-linux64-ix-016", 03:26:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:26:35 INFO - "platform": "ubuntu64_hw", 03:26:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:26:35 INFO - "branch": "mozilla-aurora", 03:26:35 INFO - "repo_path": "releases/mozilla-aurora", 03:26:35 INFO - "revision": "ddb972fb7c3721d82fb05774bbaf41806f13e545", 03:26:35 INFO - "pgo_build": "True", 03:26:35 INFO - "builduid": "ddaa3fd3500e4c1d9188a80972a92b54", 03:26:35 INFO - "slavebuilddir": "test" 03:26:35 INFO - } 03:26:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:26:35 INFO - Running post-action listener: _resource_record_post_action 03:26:35 INFO - ##### 03:26:35 INFO - ##### Running download-and-extract step. 03:26:35 INFO - ##### 03:26:35 INFO - Running pre-action listener: _resource_record_pre_action 03:26:35 INFO - Running main action method: download_and_extract 03:26:35 INFO - mkdir: /builds/slave/test/build/tests 03:26:35 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')]} 03:26:35 INFO - https://queue.taskcluster.net/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:26:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:26:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:26:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/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 03:26:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/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 03:26:44 INFO - Downloaded 1361 bytes. 03:26:44 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:26:44 INFO - Using the following test package requirements: 03:26:44 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:26:44 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:26:44 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:26:44 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:44 INFO - u'jsshell-linux-x86_64.zip'], 03:26:44 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:26:44 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:26:44 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:26:44 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:26:44 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:26:44 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:44 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:26:44 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:44 INFO - https://queue.taskcluster.net/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:26:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:26:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:26:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/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 03:26:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/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 03:26:49 INFO - Downloaded 23799830 bytes. 03:26:49 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'] 03:26:49 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 03:26:51 INFO - Return code: 0 03:26:51 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 03:26:51 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')]} 03:26:51 INFO - https://queue.taskcluster.net/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:26:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:26:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:26:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/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 03:26:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/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 03:26:53 INFO - Downloaded 23799830 bytes. 03:26:53 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'] 03:26:53 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 03:26:54 INFO - Return code: 0 03:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:54 INFO - https://queue.taskcluster.net/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:26:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/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 03:26:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/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 03:26:55 INFO - Downloaded 10840145 bytes. 03:26:55 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'] 03:26:55 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 03:26:55 INFO - Return code: 0 03:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:55 INFO - https://queue.taskcluster.net/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:26:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:26:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:26:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/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 03:26:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WB7E19M5S1imq8YNzfU8mg/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 03:26:57 INFO - Downloaded 62680147 bytes. 03:26:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:26:57 INFO - mkdir: /builds/slave/test/properties 03:26:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:26:57 INFO - Writing to file /builds/slave/test/properties/build_url 03:26:57 INFO - Contents: 03:26:57 INFO - build_url:https://queue.taskcluster.net/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:26:58 INFO - Running post-action listener: _resource_record_post_action 03:26:58 INFO - Running post-action listener: set_extra_try_arguments 03:26:58 INFO - ##### 03:26:58 INFO - ##### Running populate-webroot step. 03:26:58 INFO - ##### 03:26:58 INFO - Running pre-action listener: _resource_record_pre_action 03:26:58 INFO - Running main action method: populate_webroot 03:26:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:26:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:26:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:26:58 INFO - '--tppagecycles', 03:26:58 INFO - '7'], 03:26:58 INFO - 'tests': ['tsvgm']}}, 03:26:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:26:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:26:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:26:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:26:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:26:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:26:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:58 INFO - 'talos_options': ['--disable-e10s'], 03:26:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:58 INFO - 'talos_options': ['--disable-e10s'], 03:26:58 INFO - 'tests': ['damp', 'tps']}, 03:26:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:58 INFO - 'tests': ['damp', 'tps']}, 03:26:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:26:58 INFO - 'tests': ['dromaeo_dom']}, 03:26:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:26:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:26:58 INFO - 'tests': ['a11yr', 03:26:58 INFO - 'ts_paint', 03:26:58 INFO - 'tpaint', 03:26:58 INFO - 'sessionrestore', 03:26:58 INFO - 'sessionrestore_no_auto_restore', 03:26:58 INFO - 'tabpaint']}, 03:26:58 INFO - 'other-e10s': {'tests': ['a11yr', 03:26:58 INFO - 'ts_paint', 03:26:58 INFO - 'tpaint', 03:26:58 INFO - 'sessionrestore', 03:26:58 INFO - 'sessionrestore_no_auto_restore', 03:26:58 INFO - 'tabpaint']}, 03:26:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:26:58 INFO - 'ts_paint', 03:26:58 INFO - 'tpaint', 03:26:58 INFO - 'sessionrestore', 03:26:58 INFO - 'sessionrestore_no_auto_restore', 03:26:58 INFO - 'tabpaint']}, 03:26:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:26:58 INFO - 'ts_paint', 03:26:58 INFO - 'tpaint', 03:26:58 INFO - 'sessionrestore', 03:26:58 INFO - 'sessionrestore_no_auto_restore', 03:26:58 INFO - 'tabpaint']}, 03:26:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:26:58 INFO - 'tests': ['a11yr', 03:26:58 INFO - 'ts_paint', 03:26:58 INFO - 'tpaint', 03:26:58 INFO - 'sessionrestore', 03:26:58 INFO - 'sessionrestore_no_auto_restore', 03:26:58 INFO - 'tabpaint']}, 03:26:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:26:58 INFO - 'tests': ['a11yr', 03:26:58 INFO - 'ts_paint', 03:26:58 INFO - 'tpaint', 03:26:58 INFO - 'sessionrestore', 03:26:58 INFO - 'sessionrestore_no_auto_restore', 03:26:58 INFO - 'tabpaint']}, 03:26:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:26:58 INFO - 'tests': ['tsvgx', 03:26:58 INFO - 'tsvgr_opacity', 03:26:58 INFO - 'tart', 03:26:58 INFO - 'tscrollx', 03:26:58 INFO - 'cart']}, 03:26:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:26:58 INFO - 'tsvgr_opacity', 03:26:58 INFO - 'tart', 03:26:58 INFO - 'tscrollx', 03:26:58 INFO - 'cart']}, 03:26:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:58 INFO - 'talos_options': ['--disable-e10s'], 03:26:58 INFO - 'tests': ['tp5o']}, 03:26:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:58 INFO - 'tests': ['tp5o']}, 03:26:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:58 INFO - 'talos_options': ['--disable-e10s', 03:26:58 INFO - '--xperf_path', 03:26:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:58 INFO - 'tests': ['tp5n']}, 03:26:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:58 INFO - 'talos_options': ['--xperf_path', 03:26:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:58 INFO - 'tests': ['tp5n']}}, 03:26:58 INFO - 'talos.zip': {'path': '', 03:26:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:26:58 INFO - Running post-action listener: _resource_record_post_action 03:26:58 INFO - ##### 03:26:58 INFO - ##### Running create-virtualenv step. 03:26:58 INFO - ##### 03:26:58 INFO - Running pre-action listener: _resource_record_pre_action 03:26:58 INFO - Running main action method: create_virtualenv 03:26:58 INFO - Creating virtualenv /builds/slave/test/build/venv 03:26:58 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 03:26:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:26:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:26:58 INFO - Using real prefix '/usr' 03:26:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:26:59 INFO - Installing distribute.............................................................................................................................................................................................done. 03:27:01 INFO - Installing pip.................done. 03:27:01 INFO - Return code: 0 03:27:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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')]} 03:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:01 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 0x7fe2dc16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eca410>, '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 0x1ecb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb7a0>, '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': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', '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 03:27:01 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 03:27:01 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 03:27:01 INFO - Using env: {'DISPLAY': ':0', 03:27:01 INFO - 'HOME': '/home/cltbld', 03:27:01 INFO - 'LANG': 'en_US.UTF-8', 03:27:01 INFO - 'LANGUAGE': 'en_US:en', 03:27:01 INFO - 'LOGNAME': 'cltbld', 03:27:01 INFO - 'MAIL': '/var/mail/cltbld', 03:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:01 INFO - 'MOZ_NO_REMOTE': '1', 03:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:01 INFO - 'NO_EM_RESTART': '1', 03:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:01 INFO - 'PWD': '/builds/slave/test', 03:27:01 INFO - 'SHELL': '/bin/bash', 03:27:01 INFO - 'SHLVL': '1', 03:27:01 INFO - 'TERM': 'linux', 03:27:01 INFO - 'TMOUT': '86400', 03:27:01 INFO - 'USER': 'cltbld', 03:27:01 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', 03:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:01 INFO - '_': '/tools/buildbot/bin/python'} 03:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:01 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 03:27:01 INFO - Cleaning up... 03:27:01 INFO - Return code: 0 03:27:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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')]} 03:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:01 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 0x7fe2dc16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eca410>, '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 0x1ecb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb7a0>, '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': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', '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 03:27:01 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 03:27:01 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 03:27:01 INFO - Using env: {'DISPLAY': ':0', 03:27:01 INFO - 'HOME': '/home/cltbld', 03:27:01 INFO - 'LANG': 'en_US.UTF-8', 03:27:01 INFO - 'LANGUAGE': 'en_US:en', 03:27:01 INFO - 'LOGNAME': 'cltbld', 03:27:01 INFO - 'MAIL': '/var/mail/cltbld', 03:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:01 INFO - 'MOZ_NO_REMOTE': '1', 03:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:01 INFO - 'NO_EM_RESTART': '1', 03:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:01 INFO - 'PWD': '/builds/slave/test', 03:27:01 INFO - 'SHELL': '/bin/bash', 03:27:01 INFO - 'SHLVL': '1', 03:27:01 INFO - 'TERM': 'linux', 03:27:01 INFO - 'TMOUT': '86400', 03:27:01 INFO - 'USER': 'cltbld', 03:27:01 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', 03:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:01 INFO - '_': '/tools/buildbot/bin/python'} 03:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:01 INFO - Downloading/unpacking psutil>=0.7.1 03:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:27:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:03 INFO - Installing collected packages: psutil 03:27:03 INFO - Running setup.py install for psutil 03:27:03 INFO - building 'psutil._psutil_linux' extension 03:27:03 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 03:27:03 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 03:27:03 INFO - building 'psutil._psutil_posix' extension 03:27:03 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 03:27:04 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 03:27:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:04 INFO - Successfully installed psutil 03:27:04 INFO - Cleaning up... 03:27:04 INFO - Return code: 0 03:27:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe2dc16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eca410>, '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 0x1ecb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb7a0>, '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': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', '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 03:27:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:27:04 INFO - Using env: {'DISPLAY': ':0', 03:27:04 INFO - 'HOME': '/home/cltbld', 03:27:04 INFO - 'LANG': 'en_US.UTF-8', 03:27:04 INFO - 'LANGUAGE': 'en_US:en', 03:27:04 INFO - 'LOGNAME': 'cltbld', 03:27:04 INFO - 'MAIL': '/var/mail/cltbld', 03:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:04 INFO - 'MOZ_NO_REMOTE': '1', 03:27:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:04 INFO - 'NO_EM_RESTART': '1', 03:27:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:04 INFO - 'PWD': '/builds/slave/test', 03:27:04 INFO - 'SHELL': '/bin/bash', 03:27:04 INFO - 'SHLVL': '1', 03:27:04 INFO - 'TERM': 'linux', 03:27:04 INFO - 'TMOUT': '86400', 03:27:04 INFO - 'USER': 'cltbld', 03:27:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', 03:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:04 INFO - '_': '/tools/buildbot/bin/python'} 03:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:27:06 INFO - Installing collected packages: mozsystemmonitor 03:27:06 INFO - Running setup.py install for mozsystemmonitor 03:27:06 INFO - Successfully installed mozsystemmonitor 03:27:06 INFO - Cleaning up... 03:27:06 INFO - Return code: 0 03:27:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:27:06 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')]} 03:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:06 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')]} 03:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:06 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 0x7fe2dc16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eca410>, '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 0x1ecb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb7a0>, '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': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', '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 03:27:06 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 03:27:06 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 03:27:06 INFO - Using env: {'DISPLAY': ':0', 03:27:06 INFO - 'HOME': '/home/cltbld', 03:27:06 INFO - 'LANG': 'en_US.UTF-8', 03:27:06 INFO - 'LANGUAGE': 'en_US:en', 03:27:06 INFO - 'LOGNAME': 'cltbld', 03:27:06 INFO - 'MAIL': '/var/mail/cltbld', 03:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:06 INFO - 'MOZ_NO_REMOTE': '1', 03:27:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:06 INFO - 'NO_EM_RESTART': '1', 03:27:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:06 INFO - 'PWD': '/builds/slave/test', 03:27:06 INFO - 'SHELL': '/bin/bash', 03:27:06 INFO - 'SHLVL': '1', 03:27:06 INFO - 'TERM': 'linux', 03:27:06 INFO - 'TMOUT': '86400', 03:27:06 INFO - 'USER': 'cltbld', 03:27:06 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', 03:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:06 INFO - '_': '/tools/buildbot/bin/python'} 03:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:06 INFO - Downloading/unpacking blobuploader==1.2.4 03:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:08 INFO - Downloading blobuploader-1.2.4.tar.gz 03:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:27:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:27:08 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 03:27:08 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 03:27:08 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 03:27:08 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 03:27:08 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 03:27:08 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 03:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:27:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:27:08 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 03:27:08 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 03:27:08 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 03:27:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:09 INFO - Downloading docopt-0.6.1.tar.gz 03:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:27:09 INFO - Installing collected packages: blobuploader, requests, docopt 03:27:09 INFO - Running setup.py install for blobuploader 03:27:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:27:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:27:09 INFO - Running setup.py install for requests 03:27:09 INFO - Running setup.py install for docopt 03:27:09 INFO - Successfully installed blobuploader requests docopt 03:27:09 INFO - Cleaning up... 03:27:09 INFO - Return code: 0 03:27:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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')]} 03:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:09 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 0x7fe2dc16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eca410>, '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 0x1ecb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb7a0>, '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': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', '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 03:27:09 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 03:27:09 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 03:27:09 INFO - Using env: {'DISPLAY': ':0', 03:27:09 INFO - 'HOME': '/home/cltbld', 03:27:09 INFO - 'LANG': 'en_US.UTF-8', 03:27:09 INFO - 'LANGUAGE': 'en_US:en', 03:27:09 INFO - 'LOGNAME': 'cltbld', 03:27:09 INFO - 'MAIL': '/var/mail/cltbld', 03:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:09 INFO - 'MOZ_NO_REMOTE': '1', 03:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:09 INFO - 'NO_EM_RESTART': '1', 03:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:09 INFO - 'PWD': '/builds/slave/test', 03:27:09 INFO - 'SHELL': '/bin/bash', 03:27:09 INFO - 'SHLVL': '1', 03:27:09 INFO - 'TERM': 'linux', 03:27:09 INFO - 'TMOUT': '86400', 03:27:09 INFO - 'USER': 'cltbld', 03:27:09 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', 03:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:09 INFO - '_': '/tools/buildbot/bin/python'} 03:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:10 INFO - Running setup.py (path:/tmp/pip-eSw7rJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:10 INFO - Running setup.py (path:/tmp/pip-QlNL1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:10 INFO - Running setup.py (path:/tmp/pip-T1QE7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:10 INFO - Running setup.py (path:/tmp/pip-YsINBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:10 INFO - Running setup.py (path:/tmp/pip-r3eTZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:10 INFO - Running setup.py (path:/tmp/pip-4PUtHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:10 INFO - Running setup.py (path:/tmp/pip-qXV6Iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:10 INFO - Running setup.py (path:/tmp/pip-6VYsiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:10 INFO - Running setup.py (path:/tmp/pip-vHNnKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:10 INFO - Running setup.py (path:/tmp/pip-n0KTFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:10 INFO - Running setup.py (path:/tmp/pip-8FCNYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:10 INFO - Running setup.py (path:/tmp/pip-LMCg0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:10 INFO - Running setup.py (path:/tmp/pip-07cI3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:11 INFO - Running setup.py (path:/tmp/pip-Vq2z2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:11 INFO - Running setup.py (path:/tmp/pip-t8OfLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:11 INFO - Running setup.py (path:/tmp/pip-FPgAag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:11 INFO - Running setup.py (path:/tmp/pip-SchlhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:27:11 INFO - Running setup.py install for manifestparser 03:27:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:27:11 INFO - Running setup.py install for mozcrash 03:27:11 INFO - Running setup.py install for mozdebug 03:27:11 INFO - Running setup.py install for mozdevice 03:27:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:27:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:27:11 INFO - Running setup.py install for mozfile 03:27:11 INFO - Running setup.py install for mozhttpd 03:27:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:27:11 INFO - Running setup.py install for mozinfo 03:27:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:27:12 INFO - Running setup.py install for mozInstall 03:27:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:27:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:27:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:27:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:27:12 INFO - Running setup.py install for mozleak 03:27:12 INFO - Running setup.py install for mozlog 03:27:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:27:12 INFO - Running setup.py install for moznetwork 03:27:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:27:12 INFO - Running setup.py install for mozprocess 03:27:12 INFO - Running setup.py install for mozprofile 03:27:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:27:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:27:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:27:12 INFO - Running setup.py install for mozrunner 03:27:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:27:12 INFO - Running setup.py install for mozscreenshot 03:27:12 INFO - Running setup.py install for moztest 03:27:12 INFO - Running setup.py install for mozversion 03:27:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:27:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:27:13 INFO - Cleaning up... 03:27:13 INFO - Return code: 0 03:27:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:13 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')]} 03:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:13 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')]} 03:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:13 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 0x7fe2dc16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eca410>, '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 0x1ecb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb7a0>, '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': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', '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 03:27:13 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 03:27:13 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 03:27:13 INFO - Using env: {'DISPLAY': ':0', 03:27:13 INFO - 'HOME': '/home/cltbld', 03:27:13 INFO - 'LANG': 'en_US.UTF-8', 03:27:13 INFO - 'LANGUAGE': 'en_US:en', 03:27:13 INFO - 'LOGNAME': 'cltbld', 03:27:13 INFO - 'MAIL': '/var/mail/cltbld', 03:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:13 INFO - 'MOZ_NO_REMOTE': '1', 03:27:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:13 INFO - 'NO_EM_RESTART': '1', 03:27:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:13 INFO - 'PWD': '/builds/slave/test', 03:27:13 INFO - 'SHELL': '/bin/bash', 03:27:13 INFO - 'SHLVL': '1', 03:27:13 INFO - 'TERM': 'linux', 03:27:13 INFO - 'TMOUT': '86400', 03:27:13 INFO - 'USER': 'cltbld', 03:27:13 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', 03:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:13 INFO - '_': '/tools/buildbot/bin/python'} 03:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:13 INFO - Running setup.py (path:/tmp/pip-rSM82s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:13 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)) 03:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:13 INFO - Running setup.py (path:/tmp/pip-rQTNx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:13 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)) 03:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:13 INFO - Running setup.py (path:/tmp/pip-oILRXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:13 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)) 03:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:13 INFO - Running setup.py (path:/tmp/pip-_jF4Uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:13 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)) 03:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:13 INFO - Running setup.py (path:/tmp/pip-s9ezLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:13 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)) 03:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:13 INFO - Running setup.py (path:/tmp/pip-MUsyIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:13 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)) 03:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:13 INFO - Running setup.py (path:/tmp/pip-3LaV3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:13 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)) 03:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:13 INFO - Running setup.py (path:/tmp/pip-87PHKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:13 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)) 03:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:13 INFO - Running setup.py (path:/tmp/pip-aYTSxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:13 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)) 03:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:13 INFO - Running setup.py (path:/tmp/pip-XV4Tc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:14 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)) 03:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:14 INFO - Running setup.py (path:/tmp/pip-Nha2Zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:14 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)) 03:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:14 INFO - Running setup.py (path:/tmp/pip-_jJZqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:14 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)) 03:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:14 INFO - Running setup.py (path:/tmp/pip-X1D5Hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:14 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)) 03:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:14 INFO - Running setup.py (path:/tmp/pip-wsNc4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:14 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)) 03:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:14 INFO - Running setup.py (path:/tmp/pip-H1y2zU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:14 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)) 03:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:14 INFO - Running setup.py (path:/tmp/pip-vixGaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:14 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)) 03:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:14 INFO - Running setup.py (path:/tmp/pip-aoNJQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:14 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)) 03:27:14 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)) 03:27:14 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)) 03:27:14 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)) 03:27:14 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)) 03:27:14 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)) 03:27:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:16 INFO - Downloading blessings-1.6.tar.gz 03:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:27:16 INFO - Installing collected packages: blessings 03:27:16 INFO - Running setup.py install for blessings 03:27:16 INFO - Successfully installed blessings 03:27:16 INFO - Cleaning up... 03:27:16 INFO - Return code: 0 03:27:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:27:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:16 INFO - Reading from file tmpfile_stdout 03:27:16 INFO - Current package versions: 03:27:16 INFO - argparse == 1.2.1 03:27:16 INFO - blessings == 1.6 03:27:16 INFO - blobuploader == 1.2.4 03:27:16 INFO - docopt == 0.6.1 03:27:16 INFO - manifestparser == 1.1 03:27:16 INFO - mozInstall == 1.12 03:27:16 INFO - mozcrash == 0.17 03:27:16 INFO - mozdebug == 0.1 03:27:16 INFO - mozdevice == 0.48 03:27:16 INFO - mozfile == 1.2 03:27:16 INFO - mozhttpd == 0.7 03:27:16 INFO - mozinfo == 0.9 03:27:16 INFO - mozleak == 0.1 03:27:16 INFO - mozlog == 3.1 03:27:16 INFO - moznetwork == 0.27 03:27:16 INFO - mozprocess == 0.22 03:27:16 INFO - mozprofile == 0.28 03:27:16 INFO - mozrunner == 6.11 03:27:16 INFO - mozscreenshot == 0.1 03:27:16 INFO - mozsystemmonitor == 0.0 03:27:16 INFO - moztest == 0.7 03:27:16 INFO - mozversion == 1.4 03:27:16 INFO - psutil == 3.1.1 03:27:16 INFO - requests == 1.2.3 03:27:16 INFO - wsgiref == 0.1.2 03:27:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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')]} 03:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:16 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 0x7fe2dc16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eca410>, '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 0x1ecb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb7a0>, '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': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', '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 03:27:16 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 03:27:16 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 03:27:16 INFO - Using env: {'DISPLAY': ':0', 03:27:16 INFO - 'HOME': '/home/cltbld', 03:27:16 INFO - 'LANG': 'en_US.UTF-8', 03:27:16 INFO - 'LANGUAGE': 'en_US:en', 03:27:16 INFO - 'LOGNAME': 'cltbld', 03:27:16 INFO - 'MAIL': '/var/mail/cltbld', 03:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:16 INFO - 'MOZ_NO_REMOTE': '1', 03:27:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:16 INFO - 'NO_EM_RESTART': '1', 03:27:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:16 INFO - 'PWD': '/builds/slave/test', 03:27:16 INFO - 'SHELL': '/bin/bash', 03:27:16 INFO - 'SHLVL': '1', 03:27:16 INFO - 'TERM': 'linux', 03:27:16 INFO - 'TMOUT': '86400', 03:27:16 INFO - 'USER': 'cltbld', 03:27:16 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', 03:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:16 INFO - '_': '/tools/buildbot/bin/python'} 03:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:17 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)) 03:27:17 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)) 03:27:17 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)) 03:27:17 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)) 03:27:17 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)) 03:27:17 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)) 03:27:17 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)) 03:27:17 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)) 03:27:17 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)) 03:27:17 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)) 03:27:17 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)) 03:27:17 INFO - Cleaning up... 03:27:17 INFO - Return code: 0 03:27:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2dc16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eca410>, '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 0x1ecb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb7a0>, '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': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', '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 03:27:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:27:17 INFO - Using env: {'DISPLAY': ':0', 03:27:17 INFO - 'HOME': '/home/cltbld', 03:27:17 INFO - 'LANG': 'en_US.UTF-8', 03:27:17 INFO - 'LANGUAGE': 'en_US:en', 03:27:17 INFO - 'LOGNAME': 'cltbld', 03:27:17 INFO - 'MAIL': '/var/mail/cltbld', 03:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:17 INFO - 'MOZ_NO_REMOTE': '1', 03:27:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:17 INFO - 'NO_EM_RESTART': '1', 03:27:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:17 INFO - 'PWD': '/builds/slave/test', 03:27:17 INFO - 'SHELL': '/bin/bash', 03:27:17 INFO - 'SHLVL': '1', 03:27:17 INFO - 'TERM': 'linux', 03:27:17 INFO - 'TMOUT': '86400', 03:27:17 INFO - 'USER': 'cltbld', 03:27:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', 03:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:17 INFO - '_': '/tools/buildbot/bin/python'} 03:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:17 INFO - Downloading/unpacking jsonschema 03:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:27:19 INFO - Downloading/unpacking functools32 (from jsonschema) 03:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:19 INFO - Downloading functools32-3.2.3-2.tar.gz 03:27:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:27:19 INFO - warning: no files found matching '*.txt' 03:27:19 INFO - no previously-included directories found matching 'build' 03:27:19 INFO - no previously-included directories found matching 'dist' 03:27:19 INFO - no previously-included directories found matching '.git*' 03:27:19 INFO - Installing collected packages: jsonschema, functools32 03:27:19 INFO - Running setup.py install for functools32 03:27:19 INFO - warning: no files found matching '*.txt' 03:27:19 INFO - no previously-included directories found matching 'build' 03:27:19 INFO - no previously-included directories found matching 'dist' 03:27:19 INFO - no previously-included directories found matching '.git*' 03:27:19 INFO - Successfully installed jsonschema functools32 03:27:19 INFO - Cleaning up... 03:27:19 INFO - Return code: 0 03:27:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:19 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 0x7fe2dc16ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e3b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eca410>, '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 0x1ecb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb7a0>, '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': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', '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 03:27:19 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 03:27:19 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 03:27:19 INFO - Using env: {'DISPLAY': ':0', 03:27:19 INFO - 'HOME': '/home/cltbld', 03:27:19 INFO - 'LANG': 'en_US.UTF-8', 03:27:19 INFO - 'LANGUAGE': 'en_US:en', 03:27:19 INFO - 'LOGNAME': 'cltbld', 03:27:19 INFO - 'MAIL': '/var/mail/cltbld', 03:27:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:19 INFO - 'MOZ_NO_REMOTE': '1', 03:27:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:19 INFO - 'NO_EM_RESTART': '1', 03:27:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:19 INFO - 'PWD': '/builds/slave/test', 03:27:19 INFO - 'SHELL': '/bin/bash', 03:27:19 INFO - 'SHLVL': '1', 03:27:19 INFO - 'TERM': 'linux', 03:27:19 INFO - 'TMOUT': '86400', 03:27:19 INFO - 'USER': 'cltbld', 03:27:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', 03:27:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:19 INFO - '_': '/tools/buildbot/bin/python'} 03:27:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:19 INFO - Downloading/unpacking flake8 03:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:27:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:27: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 03:27: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 03:27: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 03:27: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 03:27: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 03:27: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 03:27:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:27:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:27: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 03:27: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 03:27: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 03:27: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 03:27: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 03:27: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 03:27:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:27:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:27:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:27:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:27:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:27:22 INFO - no previously-included directories found matching 'docs/_build' 03:27:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:27:22 INFO - Running setup.py install for pep8 03:27:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:27:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:27:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:27:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:27:22 INFO - no previously-included directories found matching 'docs/_build' 03:27:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:27:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:27:22 INFO - Cleaning up... 03:27:22 INFO - Return code: 0 03:27:22 INFO - Running post-action listener: _resource_record_post_action 03:27:22 INFO - Running post-action listener: _start_resource_monitoring 03:27:22 INFO - Starting resource monitoring. 03:27:22 INFO - ##### 03:27:22 INFO - ##### Running install step. 03:27:22 INFO - ##### 03:27:22 INFO - Running pre-action listener: _resource_record_pre_action 03:27:22 INFO - Running main action method: install 03:27:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:22 INFO - Reading from file tmpfile_stdout 03:27:22 INFO - Detecting whether we're running mozinstall >=1.0... 03:27:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:27:23 INFO - Reading from file tmpfile_stdout 03:27:23 INFO - Output received: 03:27:23 INFO - Usage: mozinstall [options] installer 03:27:23 INFO - Options: 03:27:23 INFO - -h, --help show this help message and exit 03:27:23 INFO - -d DEST, --destination=DEST 03:27:23 INFO - Directory to install application into. [default: 03:27:23 INFO - "/builds/slave/test"] 03:27:23 INFO - --app=APP Application being installed. [default: firefox] 03:27:23 INFO - mkdir: /builds/slave/test/build/application 03:27:23 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'] 03:27:23 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 03:27:38 INFO - Reading from file tmpfile_stdout 03:27:38 INFO - Output received: 03:27:38 INFO - /builds/slave/test/build/application/firefox/firefox 03:27:38 INFO - Running post-action listener: _resource_record_post_action 03:27:38 INFO - ##### 03:27:38 INFO - ##### Running run-tests step. 03:27:38 INFO - ##### 03:27:38 INFO - Running pre-action listener: _resource_record_pre_action 03:27:38 INFO - Running main action method: run_tests 03:27:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:27:38 INFO - Python 2.7.3 03:27:38 INFO - Return code: 0 03:27:38 INFO - grabbing minidump binary from tooltool 03:27:38 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')]} 03:27:38 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 0x1eca410>, '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 0x1ecb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ecb7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:27:38 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 03:27:38 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 03:27:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:27:38 INFO - Return code: 0 03:27:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:27:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:27:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:27:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:27:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:27:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:27:39 INFO - Return code: 0 03:27:39 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/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 03:27:39 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/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 03:27:39 INFO - Using env: {'DISPLAY': ':0', 03:27:39 INFO - 'HOME': '/home/cltbld', 03:27:39 INFO - 'LANG': 'en_US.UTF-8', 03:27:39 INFO - 'LANGUAGE': 'en_US:en', 03:27:39 INFO - 'LOGNAME': 'cltbld', 03:27:39 INFO - 'MAIL': '/var/mail/cltbld', 03:27:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:27:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:39 INFO - 'MOZ_NO_REMOTE': '1', 03:27:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:27:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:39 INFO - 'NO_EM_RESTART': '1', 03:27:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:39 INFO - 'PWD': '/builds/slave/test', 03:27:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:27:39 INFO - 'SHELL': '/bin/bash', 03:27:39 INFO - 'SHLVL': '1', 03:27:39 INFO - 'TERM': 'linux', 03:27:39 INFO - 'TMOUT': '86400', 03:27:39 INFO - 'USER': 'cltbld', 03:27:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894', 03:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:39 INFO - '_': '/tools/buildbot/bin/python'} 03:27:39 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/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 03:27:39 INFO - mozversion application_buildid: 20160507004025 03:27:39 INFO - mozversion application_changeset: ddb972fb7c3721d82fb05774bbaf41806f13e545 03:27:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:27:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:27:39 INFO - mozversion application_name: Firefox 03:27:39 INFO - mozversion application_remotingname: firefox-dev 03:27:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:27:39 INFO - mozversion application_vendor: Mozilla 03:27:39 INFO - mozversion application_version: 48.0a2 03:27:39 INFO - mozversion platform_buildid: 20160507004025 03:27:39 INFO - mozversion platform_changeset: ddb972fb7c3721d82fb05774bbaf41806f13e545 03:27:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:27:39 INFO - mozversion platform_version: 48.0a2 03:27:39 INFO - using testdate: 1462616859 03:27:39 INFO - actual date: 1462616859 03:27:39 INFO - starting webserver on 'localhost:46215' 03:27:39 INFO - SUITE-START | Running 2 tests 03:27:39 INFO - TEST-START | dromaeo_css 03:27:39 INFO - operating with platform_type : linux_ 03:27:39 INFO - Initialising browser for dromaeo_css test... 03:27:39 INFO - TEST-INFO | started process 6699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_a4oZe/profile http://localhost:46215/getInfo.html) 03:27:43 INFO - PROCESS | 6699 | __metrics Screen width/height:1600/1200 03:27:43 INFO - PROCESS | 6699 | colorDepth:24 03:27:43 INFO - PROCESS | 6699 | Browser inner width/height: 1024/697 03:27:43 INFO - PROCESS | 6699 | __metrics 03:27:44 ERROR - PROCESS | 6699 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:27:45 INFO - TEST-INFO | 6699: exit 0 03:27:45 INFO - Browser initialized. 03:27:45 INFO - Running cycle 1/1 for dromaeo_css test... 03:27:45 INFO - TEST-INFO | started process 6789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_a4oZe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:57 INFO - PROCESS | 6789 | RSS: Main: 142331904 03:27:57 INFO - PROCESS | 6789 | 03:28:48 INFO - PROCESS | 6789 | 1462616928980 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] 03:30:55 INFO - PROCESS | 6789 | Cycle 1(1): loaded http://localhost:46215/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46215/tests/dromaeo/cssquery-ext.html) 03:30:56 INFO - PROCESS | 6789 | RSS: Main: 254431232 03:30:56 INFO - PROCESS | 6789 | 03:33:59 INFO - PROCESS | 6789 | Cycle 1(1): loaded http://localhost:46215/tests/dromaeo/cssquery-ext.html (next: http://localhost:46215/tests/dromaeo/cssquery-jquery.html) 03:33:59 INFO - PROCESS | 6789 | RSS: Main: 222568448 03:33:59 INFO - PROCESS | 6789 | 03:37:01 INFO - PROCESS | 6789 | Cycle 1(1): loaded http://localhost:46215/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46215/tests/dromaeo/cssquery-mootools.html) 03:37:02 INFO - PROCESS | 6789 | RSS: Main: 220422144 03:37:02 INFO - PROCESS | 6789 | 03:40:04 INFO - PROCESS | 6789 | Cycle 1(1): loaded http://localhost:46215/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46215/tests/dromaeo/cssquery-prototype.html) 03:40:04 INFO - PROCESS | 6789 | RSS: Main: 214216704 03:40:04 INFO - PROCESS | 6789 | 03:43:07 INFO - PROCESS | 6789 | Cycle 1(1): loaded http://localhost:46215/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46215/tests/dromaeo/cssquery-yui.html) 03:43:07 INFO - PROCESS | 6789 | RSS: Main: 211947520 03:43:07 INFO - PROCESS | 6789 | 03:46:10 INFO - PROCESS | 6789 | Cycle 1(1): loaded http://localhost:46215/tests/dromaeo/cssquery-yui.html (next: http://localhost:46215/tests/dromaeo/cssquery-dojo.html) 03:46:10 INFO - PROCESS | 6789 | RSS: Main: 254451712 03:46:10 INFO - PROCESS | 6789 | 03:46:10 INFO - PROCESS | 6789 | __start_tp_report 03:46:10 INFO - PROCESS | 6789 | _x_x_mozilla_page_load 03:46:10 INFO - PROCESS | 6789 | _x_x_mozilla_page_load_details 03:46:10 INFO - PROCESS | 6789 | |i|pagename|runs| 03:46:10 INFO - PROCESS | 6789 | |0;dojo.html;3319.253168037192;3376.1222082258605;3392.3384939936714;3404.6595340465974;3423.0928803866977;5471.972640136799;5574.804881829137;5581.386047534773;5586.636868603538;5603.60774745768;5555.861103472415;5581.246531718217;5589.301337332833;5597.776088956437;5612.298462692163;4905.705657660534;5151.74241287935;5157.071727089123;5213.322268105141;5251.658642188265;5042.848714538552;5099.235114732801;5105.132127538309;5159.613029022819;5167.689938603696;5143.922841157386;5148.485151484859;5184.53339199472;5185.325907632003;5192.896142077157;5170;5170.224466330043;5181.974090129525;5185.844424667266;5213.635045546795;4970.602351811846;4989.401271847401;5056.342675452204;5089.821856235014;5090.847274581768;5568.16477528374;5580.972095139539;5581.05122129239;5584.86037849057;5610.13042978339;5941.55438342126;5967.522598192134;6000.009998350267;6006.249218847644;6014.51883849291;5849.736761845727;5849.7660093596205;5947.940520594782;5957.582969192158;6072.757089716406;5529.0324193266015;5533.806316778893;5534.667919924817;5535.6955367454775;5537.446255374471;6027.186329845415;6027.547933904974;6028.638281703112;6032.758689652453;6035.517158627299;5740.512056475163;5853.824385268449;5862.296524417012;5917.733701983421;5959.612625179349;5942.673152976541;5949.8215053548465;5952.702364881825;5958.344582095966;5970.492508136857;5779.826605201851;5871.3541510433815;5908.409159084057;5912.822615321547;5919.230500034968;5854.268216472941;5896.292444906553;5915.260592425947;5944.048952167633;5961.225040744675;4529.365888775574;4533.863984080483;4534.478534968521;4537.659675524349;4562.9771851141195;4010.8997275068355;4039.2123535910214;4074.4499492568716;4084.264832330209;4098.938515922264;5695.202671625976;5714.714264286769;5720.628159169641;5724.341700704389;5743;6000.429959153874;6049.122877182784;6049.364816694272;6053.51571874249;6056;5505.917411238835;5585.1901474286005;5722.7424765885635;5727.284089488814;5814.331351894586;5145.897082058338;5158.484151584811;5171.3535808024;5176.585873130216;5182.53357197854;6235.594686345464;6235.688215589294;6235.96882015587;6237.906431403532;6240.438360547572;5954.493868021266;5957.523398128226;6037.547183961308;6060.515158787374;6068.423499767515;6154.794268645956;6188.752449901954;6189.566730328834;6194.287656919512;6197.411245931629;5711.828645140652;5876.118582212703;5876.911846322223;5879.823605291848;5919.881602367843;5913.556483263858;5987.13186587951;5992.700364981821;6018.525461262019;6036.245469316335;5861.267341582302;5877.059670452707;5892.234009578728;5897.085951677325;5902.20320256777;5692.743826527733;5812.709364531672;5859.882802344015;5871.941280587311;5882.970585147047;5710.343310519177;5737.942620573741;5747.798827041033;5750.539956803362;5779.190913272229;5844.298684157929;5855.473007429352;5860;5860.824175274749;5865.677387743715;5653.321601407857;5736;5756.079027355603;5757.740901659352;5771.105478650816 03:46:10 INFO - PROCESS | 6789 | |1;ext.html;657.9934200657989;660.2110477978817;664.31243662809;671.3152584363949;734.4858598980713;39938.60061399389;40607.79696101523;40656.59343406565;40701;40718;42913.35629965553;43543.56456435443;43551.78224108875;43575.34636980448;43581.56418435815;8060.113387527367;8206.179382061806;8762.518061506631;8990.325725570576;10342.948285258562;10325.58697652093;10454.947725261402;10464.05823475887;10466.581336746522;10469.790604187912;10459.320144190604;10500.579976800918;10534.683959481228;10568.365898046104;10574.471276436187;8351;10750.247482676215;11012.284201526874;11023.118150547936;11034.889651103467;10315.07164355204;10456.111230545413;10460.633877814316;10466.319689220252;10466.372017678963;38867;39243.21513569712;39302.606973930466;39307.803460982796;39316.41025384622;3704.9259014819822;3744.101415660249;3829.100161462054;4013.25754735372;4465.062336909253;33458.33083338344;33842.83078584616;33891.15272118192;33895.49156762651;34284.314313713585;4106.404571337169;4135;4289.378040184187;4337.804798784031;4393.967417656848;308306;308403;309202;309442.4527877369;310488;38560.42159367612;63100.36899630945;64137.67931160314;64182;64218.67890660517;37303;37618.62381376206;37630.247395052495;37651.24697506035;37669.24661506809;15955.122468264124;16689.6662066758;16928.238229279712;16947.406840760515;16950;14476.855231447762;14811.925940370229;14819.110853348833;14829.925850370679;14838.258087095603;9210.677626283183;9281.628734850665;9306.302027347976;9369.812603747887;9384.5307734613;3452.4130897747445;3549.600844100222;3575.8927232183078;3586.6413358663926;3611.4041183205004;1018.251585084962;1165;1225.136278923357;1250.5060501102014;1273.802560603108;33108.66891331104;33224;34263.82868085644;34309.142271443416;34391.484127738106;1170.3329102411544;1184.5439505790162;1244.0545185658964;1248.712796056912;1362.3256488038287;16311.836881631269;16424.589385265226;16677.666446671;16771.748423773653;17114.48656540306;492582;498433;498772;499775;502023;61009;61719.38280617226;61733;61844.381556183864;61868.69065654643;1416.6458385403648;1417.7660685986903;1516.9696606067816;1618.037267825642;1622.1483721046545;30079.849600751855;33360.833195834835;33641.872012227774;33728;33756.49365259474;58129.41870581409;59891;59941.700291498266;60005;60102.39897601143;417822;428586;429643;429988;430180;39254.4111838317;46274.768626158;46315.536844631126;46494.76752616351;47463.28805067857;44927.10145797131;45141.32288015616;45942.31086533638;46412.767936160104;46653.533464666274;36255;38701.62795572298;41177.38233926553;41715.58284417117;42459.1508169841;40609.984750381474;41130.38304425376;41573;41631.58368416277;42725.57274427216;43004.56995430006;47712.761436193985;48118.278225827344;48574.75712621414;49202.75398623127;41766;43349.41454093779;44448.33327500155;44783;44918.77540612276;33725.15687107842;35076.29847403089;35102.89944233865;36001.81999089988;38155 03:46:10 INFO - PROCESS | 6789 | |2;jquery.html;426.7738098807633;427.207530031791;430.898738796383;439.2225760404085;440.7906244533846;18651.533711657215;18745;19045.80954190458;19189.04054797258;19399.22403103876;17922.462326130237;18468.90765546174;19448.222071117172;19593.412197634094;19610.901945490252;5703.458171473703;5708.4862362387275;5864.472197502224;5865.8826823463505;5879.265091863517;4295.2912769393015;5748.971255143719;5777.797777077803;6181.350958149397;6492.285848556655;6423.325550817167;6434.453071488929;6452.580582262161;6464.709088091024;6467.450266727334;5488.506034456898;5739.540836733051;5748.109043098348;5752.539796816244;6384.201974753156;3861.826217820205;5409.864753381197;5590.748416321276;5619.803306884281;5664.518515926151;13551.728965420636;13674.453021879113;13783.793243101361;13789.931050344683;20438.79561204384;2381.3927448500694;2413.8310318277727;2426.8058555315533;2447.6206188040883;3000.6249218847643;9019.864702029476;9742.561584728704;9794.412335259836;9911.752206194831;10100.23245931959;1897.6109897471124;1942.291063761731;1993.4418362858423;2066.1528773203063;2074.263636409083;75983;83903.99999999939;85366;86046;86530.13469865284;10785.838212426663;11323.377214253294;11410.828837567444;11486.94256528712;11514.136439766884;15926.203689815695;16137.35450581987;16164.272607732444;16165.757513637305;16171.110588917723;8594.44136131162;8755.474671519729;8797.164269394398;8831.072737362612;9042.367034307666;8426.283765879969;8474.5339006354;8494.277986371104;8508.489490630458;8585.570721463902;4725.149473094807;4891.682040667345;4960.305557221992;5012.373453318335;5113.769880355393;1811.499726946693;1998.430447322506;2023.3727544461265;2047.2732180076157;2122.883241421706;981.6417007792104;1040.566210860976;1098.7692584557174;1099.8460215569826;1183.946722397477;16250.024998499892;18504.074796260134;18565.16456759422;18874.62250754977;18955;1065.840123981409;1090.2858627598935;1100.2078503477483;1109.1182509904645;1113.092829344082;10557.47212639365;10598.152147828156;10660;10756;10809.729756755987;449271;454663;479399.6030019897;483260.5836970793;486901;59281.40718592759;60948;62017.37982620116;66453.66773166103;91368.54315728378;1174.3893175548837;1175.1010476985114;1194.820776883457;1209.2623499665197;1217.3183017510223;17143.539812436673;17486.387976421272;17501.47495575135;17671.64656706833;17676.2045707946;38455.61544384521;38882;41726.374104387854;42273;42286.7885660582;60358.698206508685;64026.67986660037;64427.67786161039;64663.030054548275;64706.35293647003;8781.121887811169;8845.778855528406;8861.669683370163;9021.548922553715;9113.681021164493;12224.938875305923;12719.93640031794;12990.285534295705;13485.460581576626;13497.122687025312;11682.649520514398;11718.824217636913;11722.062235021349;11781.469833857669;11859.703507412383;10765.838512422477;10865.456727163768;10957.890421095686;11008.944955275172;11234.382108984084;11431.42842857837;11952.64142075739;11981.820272696092;12063;12152.75694486123;8835.469871807712;8883.207230240949;8945.865812012955;9003.414778039407;9015.954920225357;10999.505022273857;12325.938370308091;12328.383580820744;12343.75312493763;12619.242845429304 03:46:10 INFO - PROCESS | 6789 | |3;mootools.html;1446.6383404148962;1580.1546172797553;1599.6560739441022;1782.509809802305;1903.4765439504135;8030.116687164407;8099.311558517526;8108.148644392328;8121.309688676462;8127.024757029165;7996.92003079969;8172.754817355489;8182.713605023825;8185.959070204641;8191.180881911806;2165.32874808809;2216.468047668556;2377.809775217987;2403.4111642647576;2429.975700242993;2427.8664673442954;2435.025989604155;2435.147698305597;2436.9512609747794;2439.146298795425;2356.304890057437;2388.1402695029774;2431.294924471901;2432.20953190213;2435.7807797298237;2123.3311506875284;2330.6620540021686;2370.2059809963685;2371.336025912747;2372.8220383471307;2344.695189625355;2359.197872723282;2386.642003699442;2390.8326417150806;2391.8804059797117;8113.7565873023905;8144.5113293202;8147.266745992889;8157.143499932481;8199.836003279901;5191.506806853343;5269.525742683177;5271.892902490444;5305.787768489295;5310.7610157543;3585.928281434383;3605.6394360563736;3672.7429079964413;3678.7240956928335;3695.611960744137;1105.9889401105966;1120.8374785656115;1137.5677242647741;1138.3226979947;1149.1151813103947;11777.999999999915;11817.290962542189;11895.167338286323;11918.821217681741;11928.46321915516;4682.929756053662;4745.2882067690125;4779.856604301876;4817.421909370898;4830.66185367028;10095.44475053879;10130.594776209016;10173.28786984904;10182.439965801952;10195.898041019494;5404.054290499147;5410.3507579090765;5413.7834486620095;5414.83755487336;5418.458154184629;4374.12517496502;4776.904461910812;4870.366852309177;4871.123197824355;4881.51184881509;3931.6461518463475;4020.3165461871554;4027.6576490998596;4055.209234199303;4066.4916885389325;1323.0672375975107;1350.1763924006348;1355.606874006527;1357.4163109862657;1374.896882733799;989.5101924547395;995.4375777685584;1019.0166489337824;1023.5036007536339;1033.3076838518211;5910.881782364415;5959.64242145464;6140;6142.262928448526;6179.69101544921;476.24039656748124;478.9257665061921;490.45069522135435;492.3574734970826;498.50647858619703;4237.279662457389;4246.660267178619;4255.553166917491;4257.808398622069;4259.7231179973205;9916.454594997344;10232.334898231591;10381.273310868166;10409.68770936873;10435;10113.29206955506;10156.23828212887;10248.590056397661;10255.846162307571;10264.384136951807;7506.174320824705;7797.064352277763;7983.880241796378;8055.113937466874;8063.072746634095;5985.25184351956;6013.338532761481;6018.067199584071;6137.7851775187655;6156.722947467285;8872.556372181236;8898.822023559622;9167;9199.448033118035;9233.815323693623;9040.68357607507;9315.627374904929;9439.811203776024;9444.527773611155;9454.480003599869;6739.831504212434;7202.603856787927;7338.559686418832;7393.223711510214;7609.086909570666;8051.758447246592;8106.270435660819;8124.22819832115;8143.714969976022;8160;7211.747588834365;7358.227386124594;7505.662245199088;7582.507137036075;7624;7177.318154775288;7188.101487314086;7220.205777364381;7247.166575843846;7330.560166389821;6789.830254243486;6794.388505034571;6833.282505337067;6844.041834143323;6844.555103918229;5157.200633901752;5212.478752124757;5282.366116066097;5315.149576067965;5383.246345511553;5147.305113809737;5269.288646032736;5270.89458210826;5273.630845840754;5464.071107911744 03:46:10 INFO - PROCESS | 6789 | |4;prototype.html;353.70995783457573;362.9328574213772;364.61715199041;366.6864830569863;367.5864652266199;6340.239171299445;6382.361763823621;6472.611643301405;6481.546291759579;6495.772647957322;6027.156198132265;6327.462165715908;6348.619082855021;6350.174477317943;6362.395572420613;4725.645576581753;4755.595774359166;4775.522447755231;4777.593904518103;4789.568938795508;4737.265723812798;4767.9284810727695;4773.260144677581;4778.163821331271;4790.880227994293;4622.075584883037;4725.810967561293;4734.715917044971;4784.521547845223;4794.904101917959;4658.138244424776;4759.7620118994255;4760.595349395306;4771.594414474774;4790.185668436392;4233.1322078973735;4244.957550424518;4254.510731265913;4255.127698821734;4272.4445822042935;6062.696865156725;6065.423784740443;6073.119397687311;6078.057901025348;6078.088286757022;5629.915551266734;5661.575381846378;5661.886762264773;5662.405447428002;5665.49010589049;6503;6674.733010679615;6677.599344039373;6686.699098540577;6695.966520167417;4653.278741795028;4658.697184682985;4673.532646735333;4675.158471475133;4680.882977925545;6942.201646810631;7007.684654190573;7016.298370162943;7019.298070192991;7023.92976070243;4745.406824146981;4751.809927602857;4751.95248047522;4756.9286460703115;4760.190767569521;4812;4814.855554333376;4815.470298267188;4815.927761083586;4816.036792641486;5550.47270509301;5559.27729395176;5561.277033985637;5561.860953476195;5571.4150014248735;6584.5061620378665;6746.291639377795;6752.898706519406;6756.425703815133;6761.154855643044;1673.322304466693;1696.881218314706;1700.4898530440819;1702.761613374104;1703.693335199651;1055.9102476289602;1107.3355986408092;1112.8386383974441;1131.4329653429895;1136.3693150301497;6494.285628580852;6495.025746138117;6501.934980650228;6503;6542.051402546604;6917.827054323682;6918.965405172942;6923.549969252083;6926.307369263134;6938.924466707668;6489.837754056092;6491.058796474485;6492.415682588589;6493.090967264587;6495.545311828127;3730.421784623388;3762.5108735864164;3762.887113386603;3763.6800871925643;3768.3217020936495;7088.468364872655;7240.601766902871;7249.383802376857;7277.345038946414;7352.5956072415465;7122.5726456412785;7151;7167.247439018932;7169.354758071799;7170.426365890717;7308.415326773846;7310.4517161213125;7313.67088481009;7319.048523691992;7323.560586364835;6889.311068893071;7048.471364647569;7051.823704407431;7061.576305421691;7061.894071589033;6919.965400173169;6923.723051077901;6927.168739751262;6928.064711264116;6929.480288978246;7247.021652076902;7283.089613798275;7287.194430144326;7289.45329100309;7296.087989001375;4796.95203047979;4831.830885918976;4833.879153021203;4837.4920633332995;4841.080194762983;7020.473464490082;7021.859562808818;7025.68384422692;7027.824304392431;7029.929700702927;6654.700538475877;6838.931610684029;6839.31606839332;6839.384455399038;6855;6751.898721519279;6786.728530858711;6797.490188236001;6804.353586409283;6805.081314022544;6693.397594216543;6698.66506674674;6707.798766037026;6709.765158219634;6714.496412768965;6659.600423974577;6859.416949559144;6859.7256109757045;6864.759733409307;6874.312568743086;6464.709088091141;6564.901526477011;6668.066470694203;6682.2649508555;6699.5310328276555 03:46:10 INFO - PROCESS | 6789 | |5;yui.html;794.1581923161449;826.7809030606886;892.4110087342353;899.123354729139;912.3112050401945;14813.777793333094;15009.474668386609;15230.847691523095;15264.771028434583;15277.388904443837;14309.57071287863;14335.139891606512;14390.352434140463;14390.712185756278;14391.136531808099;723.1105739939891;877.8376000439939;901.2294488212549;901.5221932375852;904.6426661468716;888.2006194425037;896.3277541843618;897.2687259883174;897.7979954510248;898.6405437824857;942.2979879989417;944.0323668240075;944.1361154543584;944.1785646487531;945.121037435185;774.1948373691354;942.241495596045;953.5280036382036;955.1499165742425;955.7945041816008;703.8134894252976;704.0741425026074;704.1514974455769;704.3203308807026;704.5526090932244;14294.142351458946;14326.212058336787;14370.784438233435;14383.065100768417;14384.928075359661;13937.651558711012;14073.788893166611;14275.928620356935;14630.122192668474;14650.487232946902;11339.659810205625;11490.138239631977;11659.12556558253;11759.470823812864;11965.401729913556;4000;4035.25347810653;4070.8575199867864;4131.752094874317;4158.064435501988;56102.43897561013;56275;56369.71815140939;56818.715906420206;56878.71560642212;11312.484781020583;11694.590689325832;11696.298222106701;11718.941405292919;11866.703332416586;19679.60640787205;19744.40766776999;19834.404967850987;19871.105800239024;19942.302019429542;8613.440126391764;8635.525046122399;8734.650613975497;8786.297096232285;8980.012198658142;4728.148933192058;4985.376827896513;5193.221016847428;5197.246399272084;5246.895062098737;3589.5333606631493;3631.2737452509605;3633.5821380541574;3639.6178401268016;3646.9452958205648;699.7655785311875;705.4215543254585;708.6952610377588;710.0378986473357;722.3282347416848;745.4520927118564;788.1960400391569;800.7669877351595;803.1727320859524;819.663937785505;10030.29787914839;10158.339707918962;10197.898021019842;10240.436775977392;10315.535800888978;733.6258508160877;804.7891877462387;820.1306614988013;840.1850205300971;849.482083560497;4732.337472753818;4738.976305118453;4751.619870410359;4800.975995120002;4834;67205.32794672088;68316;69719.3028069723;70399.29600704029;70939.2906070943;58948;59838;59939.700301499084;60126.398736012954;60738;54642.72678636581;54728.45271547313;55214.72392638011;55414;55849;9331.393459425115;9424.57589408492;9485.383450075724;9568.56941437623;9598.520073996411;40444;40835.38746918858;41400.79299603483;41502.584974149875;42656.36015459709;52782.736086319324;53515.73242133764;53829.730851347056;53976.46023539714;54794.45205548053;11857.11071669611;11883.346415947206;11892.464839082435;12035.45840437165;12371.505139794308;11195.552177912792;12635.747285054063;13099.409375233405;13201.933990329986;13244.337783110614;13046.347682615642;13060.281684507443;13175.14361566495;13197.142185757895;13443.991700622297;13707.931460342634;13719;13833.239171845646;13918.51285205013;14127.576172714835;13017.974277164529;13119.212847229197;13625.197446770375;13659.86340136586;13767.862321376659;10895;11138.777224455303;11159.776804463703;11518.308901465938;11689.240199387013;11296.894199819988;11498;11683.766324673288;11688.532458701557;11801.645950621494 03:46:10 INFO - PROCESS | 6789 | __end_tp_report 03:46:10 INFO - PROCESS | 6789 | __start_cc_report 03:46:10 INFO - PROCESS | 6789 | _x_x_mozilla_cycle_collect,885 03:46:10 INFO - PROCESS | 6789 | __end_cc_report 03:46:10 INFO - PROCESS | 6789 | __startTimestamp1462617970424__endTimestamp 03:46:10 INFO - PROCESS | 6789 | 03:46:10 INFO - PROCESS | 6789 | ------- Summary: start ------- 03:46:10 INFO - PROCESS | 6789 | Number of tests: 6 03:46:10 INFO - PROCESS | 6789 | 03:46:10 INFO - PROCESS | 6789 | [#0] dojo.html Cycles:165 Average:5557.36 Median:5750.54 stddev:608.43 (10.6%) stddev-sans-first:584.42 03:46:10 INFO - PROCESS | 6789 | Values: 3319.3 3376.1 3392.3 3404.7 3423.1 5472.0 5574.8 5581.4 5586.6 5603.6 5555.9 5581.2 5589.3 5597.8 5612.3 4905.7 5151.7 5157.1 5213.3 5251.7 5042.8 5099.2 5105.1 5159.6 5167.7 5143.9 5148.5 5184.5 5185.3 5192.9 5170.0 5170.2 5182.0 5185.8 5213.6 4970.6 4989.4 5056.3 5089.8 5090.8 5568.2 5581.0 5581.1 5584.9 5610.1 5941.6 5967.5 6000.0 6006.2 6014.5 5849.7 5849.8 5947.9 5957.6 6072.8 5529.0 5533.8 5534.7 5535.7 5537.4 6027.2 6027.5 6028.6 6032.8 6035.5 5740.5 5853.8 5862.3 5917.7 5959.6 5942.7 5949.8 5952.7 5958.3 5970.5 5779.8 5871.4 5908.4 5912.8 5919.2 5854.3 5896.3 5915.3 5944.0 5961.2 4529.4 4533.9 4534.5 4537.7 4563.0 4010.9 4039.2 4074.4 4084.3 4098.9 5695.2 5714.7 5720.6 5724.3 5743.0 6000.4 6049.1 6049.4 6053.5 6056.0 5505.9 5585.2 5722.7 5727.3 5814.3 5145.9 5158.5 5171.4 5176.6 5182.5 6235.6 6235.7 6236.0 6237.9 6240.4 5954.5 5957.5 6037.5 6060.5 6068.4 6154.8 6188.8 6189.6 6194.3 6197.4 5711.8 5876.1 5876.9 5879.8 5919.9 5913.6 5987.1 5992.7 6018.5 6036.2 5861.3 5877.1 5892.2 5897.1 5902.2 5692.7 5812.7 5859.9 5871.9 5883.0 5710.3 5737.9 5747.8 5750.5 5779.2 5844.3 5855.5 5860.0 5860.8 5865.7 5653.3 5736.0 5756.1 5757.7 5771.1 03:46:10 INFO - PROCESS | 6789 | 03:46:10 INFO - PROCESS | 6789 | [#1] ext.html Cycles:180 Average:58335.30 Median:38784.31 stddev:110748.68 (285.6%) stddev-sans-first:110974.69 03:46:10 INFO - PROCESS | 6789 | Values: 658.0 660.2 664.3 671.3 734.5 39938.6 40607.8 40656.6 40701.0 40718.0 42913.4 43543.6 43551.8 43575.3 43581.6 8060.1 8206.2 8762.5 8990.3 10342.9 10325.6 10454.9 10464.1 10466.6 10469.8 10459.3 10500.6 10534.7 10568.4 10574.5 8351.0 10750.2 11012.3 11023.1 11034.9 10315.1 10456.1 10460.6 10466.3 10466.4 38867.0 39243.2 39302.6 39307.8 39316.4 3704.9 3744.1 3829.1 4013.3 4465.1 33458.3 33842.8 33891.2 33895.5 34284.3 4106.4 4135.0 4289.4 4337.8 4394.0 308306.0 308403.0 309202.0 309442.5 310488.0 38560.4 63100.4 64137.7 64182.0 64218.7 37303.0 37618.6 37630.2 37651.2 37669.2 15955.1 16689.7 16928.2 16947.4 16950.0 14476.9 14811.9 14819.1 14829.9 14838.3 9210.7 9281.6 9306.3 9369.8 9384.5 3452.4 3549.6 3575.9 3586.6 3611.4 1018.3 1165.0 1225.1 1250.5 1273.8 33108.7 33224.0 34263.8 34309.1 34391.5 1170.3 1184.5 1244.1 1248.7 1362.3 16311.8 16424.6 16677.7 16771.7 17114.5 492582.0 498433.0 498772.0 499775.0 502023.0 61009.0 61719.4 61733.0 61844.4 61868.7 1416.6 1417.8 1517.0 1618.0 1622.1 30079.8 33360.8 33641.9 33728.0 33756.5 58129.4 59891.0 59941.7 60005.0 60102.4 417822.0 428586.0 429643.0 429988.0 430180.0 39254.4 46274.8 46315.5 46494.8 47463.3 44927.1 45141.3 45942.3 46412.8 46653.5 36255.0 38701.6 41177.4 41715.6 42459.2 40610.0 41130.4 41573.0 41631.6 42725.6 43004.6 47712.8 48118.3 48574.8 49202.8 41766.0 43349.4 44448.3 44783.0 44918.8 33725.2 35076.3 35102.9 36001.8 38155.0 03:46:10 INFO - PROCESS | 6789 | 03:46:10 INFO - PROCESS | 6789 | [#2] jquery.html Cycles:180 Average:27844.98 Median:2397.61 stddev:77459.47 (3230.7%) stddev-sans-first:77649.40 03:46:10 INFO - PROCESS | 6789 | Values: 426.8 427.2 430.9 439.2 440.8 18651.5 18745.0 19045.8 19189.0 19399.2 17922.5 18468.9 19448.2 19593.4 19610.9 5703.5 5708.5 5864.5 5865.9 5879.3 4295.3 5749.0 5777.8 6181.4 6492.3 6423.3 6434.5 6452.6 6464.7 6467.5 5488.5 5739.5 5748.1 5752.5 6384.2 3861.8 5409.9 5590.7 5619.8 5664.5 13551.7 13674.5 13783.8 13789.9 20438.8 2381.4 2413.8 2426.8 2447.6 3000.6 9019.9 9742.6 9794.4 9911.8 10100.2 1897.6 1942.3 1993.4 2066.2 2074.3 75983.0 83904.0 85366.0 86046.0 86530.1 10785.8 11323.4 11410.8 11486.9 11514.1 15926.2 16137.4 16164.3 16165.8 16171.1 8594.4 8755.5 8797.2 8831.1 9042.4 8426.3 8474.5 8494.3 8508.5 8585.6 4725.1 4891.7 4960.3 5012.4 5113.8 1811.5 1998.4 2023.4 2047.3 2122.9 981.6 1040.6 1098.8 1099.8 1183.9 16250.0 18504.1 18565.2 18874.6 18955.0 1065.8 1090.3 1100.2 1109.1 1113.1 10557.5 10598.2 10660.0 10756.0 10809.7 449271.0 454663.0 479399.6 483260.6 486901.0 59281.4 60948.0 62017.4 66453.7 91368.5 1174.4 1175.1 1194.8 1209.3 1217.3 17143.5 17486.4 17501.5 17671.6 17676.2 38455.6 38882.0 41726.4 42273.0 42286.8 60358.7 64026.7 64427.7 64663.0 64706.4 8781.1 8845.8 8861.7 9021.5 9113.7 12224.9 12719.9 12990.3 13485.5 13497.1 11682.6 11718.8 11722.1 11781.5 11859.7 10765.8 10865.5 10957.9 11008.9 11234.4 11431.4 11952.6 11981.8 12063.0 12152.8 8835.5 8883.2 8945.9 9003.4 9016.0 10999.5 12325.9 12328.4 12343.8 12619.2 03:46:10 INFO - PROCESS | 6789 | 03:46:10 INFO - PROCESS | 6789 | [#3] mootools.html Cycles:180 Average:5621.84 Median:495.43 stddev:3053.80 (616.4%) stddev-sans-first:3046.24 03:46:10 INFO - PROCESS | 6789 | Values: 1446.6 1580.2 1599.7 1782.5 1903.5 8030.1 8099.3 8108.1 8121.3 8127.0 7996.9 8172.8 8182.7 8186.0 8191.2 2165.3 2216.5 2377.8 2403.4 2430.0 2427.9 2435.0 2435.1 2437.0 2439.1 2356.3 2388.1 2431.3 2432.2 2435.8 2123.3 2330.7 2370.2 2371.3 2372.8 2344.7 2359.2 2386.6 2390.8 2391.9 8113.8 8144.5 8147.3 8157.1 8199.8 5191.5 5269.5 5271.9 5305.8 5310.8 3585.9 3605.6 3672.7 3678.7 3695.6 1106.0 1120.8 1137.6 1138.3 1149.1 11778.0 11817.3 11895.2 11918.8 11928.5 4682.9 4745.3 4779.9 4817.4 4830.7 10095.4 10130.6 10173.3 10182.4 10195.9 5404.1 5410.4 5413.8 5414.8 5418.5 4374.1 4776.9 4870.4 4871.1 4881.5 3931.6 4020.3 4027.7 4055.2 4066.5 1323.1 1350.2 1355.6 1357.4 1374.9 989.5 995.4 1019.0 1023.5 1033.3 5910.9 5959.6 6140.0 6142.3 6179.7 476.2 478.9 490.5 492.4 498.5 4237.3 4246.7 4255.6 4257.8 4259.7 9916.5 10232.3 10381.3 10409.7 10435.0 10113.3 10156.2 10248.6 10255.8 10264.4 7506.2 7797.1 7983.9 8055.1 8063.1 5985.3 6013.3 6018.1 6137.8 6156.7 8872.6 8898.8 9167.0 9199.4 9233.8 9040.7 9315.6 9439.8 9444.5 9454.5 6739.8 7202.6 7338.6 7393.2 7609.1 8051.8 8106.3 8124.2 8143.7 8160.0 7211.7 7358.2 7505.7 7582.5 7624.0 7177.3 7188.1 7220.2 7247.2 7330.6 6789.8 6794.4 6833.3 6844.0 6844.6 5157.2 5212.5 5282.4 5315.1 5383.2 5147.3 5269.3 5270.9 5273.6 5464.1 03:46:10 INFO - PROCESS | 6789 | 03:46:10 INFO - PROCESS | 6789 | [#4] prototype.html Cycles:180 Average:5646.19 Median:6490.45 stddev:1721.60 (26.5%) stddev-sans-first:1679.98 03:46:10 INFO - PROCESS | 6789 | Values: 353.7 362.9 364.6 366.7 367.6 6340.2 6382.4 6472.6 6481.5 6495.8 6027.2 6327.5 6348.6 6350.2 6362.4 4725.6 4755.6 4775.5 4777.6 4789.6 4737.3 4767.9 4773.3 4778.2 4790.9 4622.1 4725.8 4734.7 4784.5 4794.9 4658.1 4759.8 4760.6 4771.6 4790.2 4233.1 4245.0 4254.5 4255.1 4272.4 6062.7 6065.4 6073.1 6078.1 6078.1 5629.9 5661.6 5661.9 5662.4 5665.5 6503.0 6674.7 6677.6 6686.7 6696.0 4653.3 4658.7 4673.5 4675.2 4680.9 6942.2 7007.7 7016.3 7019.3 7023.9 4745.4 4751.8 4752.0 4756.9 4760.2 4812.0 4814.9 4815.5 4815.9 4816.0 5550.5 5559.3 5561.3 5561.9 5571.4 6584.5 6746.3 6752.9 6756.4 6761.2 1673.3 1696.9 1700.5 1702.8 1703.7 1055.9 1107.3 1112.8 1131.4 1136.4 6494.3 6495.0 6501.9 6503.0 6542.1 6917.8 6919.0 6923.5 6926.3 6938.9 6489.8 6491.1 6492.4 6493.1 6495.5 3730.4 3762.5 3762.9 3763.7 3768.3 7088.5 7240.6 7249.4 7277.3 7352.6 7122.6 7151.0 7167.2 7169.4 7170.4 7308.4 7310.5 7313.7 7319.0 7323.6 6889.3 7048.5 7051.8 7061.6 7061.9 6920.0 6923.7 6927.2 6928.1 6929.5 7247.0 7283.1 7287.2 7289.5 7296.1 4797.0 4831.8 4833.9 4837.5 4841.1 7020.5 7021.9 7025.7 7027.8 7029.9 6654.7 6838.9 6839.3 6839.4 6855.0 6751.9 6786.7 6797.5 6804.4 6805.1 6693.4 6698.7 6707.8 6709.8 6714.5 6659.6 6859.4 6859.7 6864.8 6874.3 6464.7 6564.9 6668.1 6682.3 6699.5 03:46:10 INFO - PROCESS | 6789 | 03:46:10 INFO - PROCESS | 6789 | [#5] yui.html Cycles:180 Average:16078.07 Median:4730.24 stddev:18989.40 (401.4%) stddev-sans-first:19007.98 03:46:10 INFO - PROCESS | 6789 | Values: 794.2 826.8 892.4 899.1 912.3 14813.8 15009.5 15230.8 15264.8 15277.4 14309.6 14335.1 14390.4 14390.7 14391.1 723.1 877.8 901.2 901.5 904.6 888.2 896.3 897.3 897.8 898.6 942.3 944.0 944.1 944.2 945.1 774.2 942.2 953.5 955.1 955.8 703.8 704.1 704.2 704.3 704.6 14294.1 14326.2 14370.8 14383.1 14384.9 13937.7 14073.8 14275.9 14630.1 14650.5 11339.7 11490.1 11659.1 11759.5 11965.4 4000.0 4035.3 4070.9 4131.8 4158.1 56102.4 56275.0 56369.7 56818.7 56878.7 11312.5 11694.6 11696.3 11718.9 11866.7 19679.6 19744.4 19834.4 19871.1 19942.3 8613.4 8635.5 8734.7 8786.3 8980.0 4728.1 4985.4 5193.2 5197.2 5246.9 3589.5 3631.3 3633.6 3639.6 3646.9 699.8 705.4 708.7 710.0 722.3 745.5 788.2 800.8 803.2 819.7 10030.3 10158.3 10197.9 10240.4 10315.5 733.6 804.8 820.1 840.2 849.5 4732.3 4739.0 4751.6 4801.0 4834.0 67205.3 68316.0 69719.3 70399.3 70939.3 58948.0 59838.0 59939.7 60126.4 60738.0 54642.7 54728.5 55214.7 55414.0 55849.0 9331.4 9424.6 9485.4 9568.6 9598.5 40444.0 40835.4 41400.8 41502.6 42656.4 52782.7 53515.7 53829.7 53976.5 54794.5 11857.1 11883.3 11892.5 12035.5 12371.5 11195.6 12635.7 13099.4 13201.9 13244.3 13046.3 13060.3 13175.1 13197.1 13444.0 13707.9 13719.0 13833.2 13918.5 14127.6 13018.0 13119.2 13625.2 13659.9 13767.9 10895.0 11138.8 11159.8 11518.3 11689.2 11296.9 11498.0 11683.8 11688.5 11801.6 03:46:10 INFO - PROCESS | 6789 | -------- Summary: end -------- 03:46:10 INFO - PROCESS | 6789 | 03:46:11 INFO - TEST-INFO | 6789: exit 0 03:46:11 INFO - TEST-OK | dromaeo_css | took 1111290ms 03:46:11 INFO - TEST-START | kraken 03:46:11 INFO - operating with platform_type : linux_ 03:46:11 INFO - Initialising browser for kraken test... 03:46:11 INFO - TEST-INFO | started process 6986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJe6CCy/profile http://localhost:46215/getInfo.html) 03:46:14 INFO - PROCESS | 6986 | __metrics Screen width/height:1600/1200 03:46:14 INFO - PROCESS | 6986 | colorDepth:24 03:46:14 INFO - PROCESS | 6986 | Browser inner width/height: 1024/697 03:46:14 INFO - PROCESS | 6986 | __metrics 03:46:15 ERROR - PROCESS | 6986 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:46:16 INFO - TEST-INFO | 6986: exit 0 03:46:16 INFO - Browser initialized. 03:46:16 INFO - Running cycle 1/1 for kraken test... 03:46:16 INFO - TEST-INFO | started process 7078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJe6CCy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:46:28 INFO - PROCESS | 7078 | RSS: Main: 141848576 03:46:28 INFO - PROCESS | 7078 | 03:46:30 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:46215/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46215/tests/kraken/driver.html?testName=audio-beat-detection) 03:46:31 INFO - PROCESS | 7078 | RSS: Main: 197345280 03:46:31 INFO - PROCESS | 7078 | 03:46:34 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:46215/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46215/tests/kraken/driver.html?testName=audio-dft) 03:46:34 INFO - PROCESS | 7078 | RSS: Main: 182476800 03:46:34 INFO - PROCESS | 7078 | 03:46:37 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:46215/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46215/tests/kraken/driver.html?testName=audio-fft) 03:46:38 INFO - PROCESS | 7078 | RSS: Main: 273215488 03:46:38 INFO - PROCESS | 7078 | 03:46:40 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:46215/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46215/tests/kraken/driver.html?testName=audio-oscillator) 03:46:41 INFO - PROCESS | 7078 | RSS: Main: 180129792 03:46:41 INFO - PROCESS | 7078 | 03:46:43 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:46215/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46215/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:46:43 INFO - PROCESS | 7078 | RSS: Main: 177549312 03:46:43 INFO - PROCESS | 7078 | 03:46:46 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:46215/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46215/tests/kraken/driver.html?testName=imaging-darkroom) 03:46:47 INFO - PROCESS | 7078 | RSS: Main: 212303872 03:46:47 INFO - PROCESS | 7078 | 03:46:50 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:46215/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46215/tests/kraken/driver.html?testName=imaging-desaturate) 03:46:51 INFO - PROCESS | 7078 | RSS: Main: 212267008 03:46:51 INFO - PROCESS | 7078 | 03:46:54 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:46215/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46215/tests/kraken/driver.html?testName=json-parse-financial) 03:46:54 INFO - PROCESS | 7078 | RSS: Main: 212619264 03:46:54 INFO - PROCESS | 7078 | 03:46:56 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:46215/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46215/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:46:56 INFO - PROCESS | 7078 | RSS: Main: 191737856 03:46:56 INFO - PROCESS | 7078 | 03:46:58 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:46215/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46215/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:46:59 INFO - PROCESS | 7078 | RSS: Main: 194326528 03:46:59 INFO - PROCESS | 7078 | 03:47:01 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:46215/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46215/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:47:01 INFO - PROCESS | 7078 | RSS: Main: 209215488 03:47:01 INFO - PROCESS | 7078 | 03:47:04 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:46215/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46215/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:47:04 INFO - PROCESS | 7078 | RSS: Main: 214884352 03:47:04 INFO - PROCESS | 7078 | 03:47:07 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:46215/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46215/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:47:08 INFO - PROCESS | 7078 | RSS: Main: 209219584 03:47:08 INFO - PROCESS | 7078 | 03:47:09 INFO - PROCESS | 7078 | Cycle 1(1): loaded http://localhost:46215/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46215/tests/kraken/driver.html?testName=ai-astar) 03:47:10 INFO - PROCESS | 7078 | RSS: Main: 273297408 03:47:10 INFO - PROCESS | 7078 | 03:47:10 INFO - PROCESS | 7078 | __start_tp_report 03:47:10 INFO - PROCESS | 7078 | _x_x_mozilla_page_load 03:47:10 INFO - PROCESS | 7078 | _x_x_mozilla_page_load_details 03:47:10 INFO - PROCESS | 7078 | |i|pagename|runs| 03:47:10 INFO - PROCESS | 7078 | |0;ai-astar;113;110;110;111;110;111;106;110;110;111 03:47:10 INFO - PROCESS | 7078 | |1;audio-beat-detection;160;146;164;181;126;159;152;129;191;131 03:47:10 INFO - PROCESS | 7078 | |2;audio-dft;163;161;160;161;161;161;161;162;160;161 03:47:10 INFO - PROCESS | 7078 | |3;audio-fft;76;73;77;173;72;76;76;74;184;76 03:47:10 INFO - PROCESS | 7078 | |4;audio-oscillator;92;93;151;92;92;92;150;93;93;152 03:47:10 INFO - PROCESS | 7078 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;116;117 03:47:10 INFO - PROCESS | 7078 | |6;imaging-darkroom;145;145;145;146;145;146;145;145;145;145 03:47:10 INFO - PROCESS | 7078 | |7;imaging-desaturate;95;94;95;95;95;94;95;94;95;94 03:47:10 INFO - PROCESS | 7078 | |8;json-parse-financial;55;56;55;54;55;55;57;73;53;55 03:47:10 INFO - PROCESS | 7078 | |9;json-stringify-tinderbox;60;58;58;58;59;59;58;58;59;58 03:47:10 INFO - PROCESS | 7078 | |10;stanford-crypto-aes;81;72;81;72;74;73;74;74;73;82 03:47:10 INFO - PROCESS | 7078 | |11;stanford-crypto-ccm;114;122;116;123;110;116;120;111;131;139 03:47:10 INFO - PROCESS | 7078 | |12;stanford-crypto-pbkdf2;157;156;158;158;164;160;160;157;158;155 03:47:10 INFO - PROCESS | 7078 | |13;stanford-crypto-sha256-iterative;68;67;67;64;65;67;65;67;67;64 03:47:10 INFO - PROCESS | 7078 | __end_tp_report 03:47:10 INFO - PROCESS | 7078 | __start_cc_report 03:47:10 INFO - PROCESS | 7078 | _x_x_mozilla_cycle_collect,1570 03:47:10 INFO - PROCESS | 7078 | __end_cc_report 03:47:10 INFO - PROCESS | 7078 | __startTimestamp1462618030011__endTimestamp 03:47:10 INFO - PROCESS | 7078 | 03:47:10 INFO - PROCESS | 7078 | ------- Summary: start ------- 03:47:10 INFO - PROCESS | 7078 | Number of tests: 14 03:47:10 INFO - PROCESS | 7078 | 03:47:10 INFO - PROCESS | 7078 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:1.75 (1.6%) stddev-sans-first:1.54 03:47:10 INFO - PROCESS | 7078 | Values: 113.0 110.0 110.0 111.0 110.0 111.0 106.0 110.0 110.0 111.0 03:47:10 INFO - PROCESS | 7078 | 03:47:10 INFO - PROCESS | 7078 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:159.50 stddev:21.77 (13.6%) stddev-sans-first:22.98 03:47:10 INFO - PROCESS | 7078 | Values: 160.0 146.0 164.0 181.0 126.0 159.0 152.0 129.0 191.0 131.0 03:47:10 INFO - PROCESS | 7078 | 03:47:10 INFO - PROCESS | 7078 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.60 03:47:10 INFO - PROCESS | 7078 | Values: 163.0 161.0 160.0 161.0 161.0 161.0 161.0 162.0 160.0 161.0 03:47:10 INFO - PROCESS | 7078 | 03:47:10 INFO - PROCESS | 7078 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:43.74 (57.6%) stddev-sans-first:45.81 03:47:10 INFO - PROCESS | 7078 | Values: 76.0 73.0 77.0 173.0 72.0 76.0 76.0 74.0 184.0 76.0 03:47:10 INFO - PROCESS | 7078 | 03:47:10 INFO - PROCESS | 7078 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:92.00 stddev:28.30 (30.8%) stddev-sans-first:29.26 03:47:10 INFO - PROCESS | 7078 | Values: 92.0 93.0 151.0 92.0 92.0 92.0 150.0 93.0 93.0 152.0 03:47:10 INFO - PROCESS | 7078 | 03:47:10 INFO - PROCESS | 7078 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:47:10 INFO - PROCESS | 7078 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 03:47:10 INFO - PROCESS | 7078 | 03:47:10 INFO - PROCESS | 7078 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 03:47:10 INFO - PROCESS | 7078 | Values: 145.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 03:47:10 INFO - PROCESS | 7078 | 03:47:10 INFO - PROCESS | 7078 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:47:10 INFO - PROCESS | 7078 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 03:47:10 INFO - PROCESS | 7078 | 03:47:10 INFO - PROCESS | 7078 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:55.00 stddev:5.79 (10.5%) stddev-sans-first:6.10 03:47:10 INFO - PROCESS | 7078 | Values: 55.0 56.0 55.0 54.0 55.0 55.0 57.0 73.0 53.0 55.0 03:47:10 INFO - PROCESS | 7078 | 03:47:10 INFO - PROCESS | 7078 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:58.50 stddev:0.71 (1.2%) stddev-sans-first:0.50 03:47:10 INFO - PROCESS | 7078 | Values: 60.0 58.0 58.0 58.0 59.0 59.0 58.0 58.0 59.0 58.0 03:47:10 INFO - PROCESS | 7078 | 03:47:10 INFO - PROCESS | 7078 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:74.00 stddev:4.03 (5.5%) stddev-sans-first:3.77 03:47:10 INFO - PROCESS | 7078 | Values: 81.0 72.0 81.0 72.0 74.0 73.0 74.0 74.0 73.0 82.0 03:47:10 INFO - PROCESS | 7078 | 03:47:10 INFO - PROCESS | 7078 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:121.00 stddev:9.09 (7.5%) stddev-sans-first:9.36 03:47:10 INFO - PROCESS | 7078 | Values: 114.0 122.0 116.0 123.0 110.0 116.0 120.0 111.0 131.0 139.0 03:47:10 INFO - PROCESS | 7078 | 03:47:10 INFO - PROCESS | 7078 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:158.00 stddev:2.54 (1.6%) stddev-sans-first:2.65 03:47:10 INFO - PROCESS | 7078 | Values: 157.0 156.0 158.0 158.0 164.0 160.0 160.0 157.0 158.0 155.0 03:47:10 INFO - PROCESS | 7078 | 03:47:10 INFO - PROCESS | 7078 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:67.00 stddev:1.45 (2.2%) stddev-sans-first:1.36 03:47:10 INFO - PROCESS | 7078 | Values: 68.0 67.0 67.0 64.0 65.0 67.0 65.0 67.0 67.0 64.0 03:47:10 INFO - PROCESS | 7078 | -------- Summary: end -------- 03:47:10 INFO - PROCESS | 7078 | 03:47:10 INFO - TEST-INFO | 7078: exit 0 03:47:10 INFO - TEST-OK | kraken | took 59878ms 03:47:10 INFO - SUITE-END | took 1171s 03:47:11 INFO - Completed test suite (00:19:31) 03:47:11 INFO - javascript benchmark 03:47:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3319.253168037192, 3376.1222082258605, 3392.3384939936714, 3404.6595340465974, 3423.0928803866977, 5471.972640136799, 5574.804881829137, 5581.386047534773, 5586.636868603538, 5603.60774745768, 5555.861103472415, 5581.246531718217, 5589.301337332833, 5597.776088956437, 5612.298462692163, 4905.705657660534, 5151.74241287935, 5157.071727089123, 5213.322268105141, 5251.658642188265, 5042.848714538552, 5099.235114732801, 5105.132127538309, 5159.613029022819, 5167.689938603696, 5143.922841157386, 5148.485151484859, 5184.53339199472, 5185.325907632003, 5192.896142077157, 5170.0, 5170.224466330043, 5181.974090129525, 5185.844424667266, 5213.635045546795, 4970.602351811846, 4989.401271847401, 5056.342675452204, 5089.821856235014, 5090.847274581768, 5568.16477528374, 5580.972095139539, 5581.05122129239, 5584.86037849057, 5610.13042978339, 5941.55438342126, 5967.522598192134, 6000.009998350267, 6006.249218847644, 6014.51883849291, 5849.736761845727, 5849.7660093596205, 5947.940520594782, 5957.582969192158, 6072.757089716406, 5529.0324193266015, 5533.806316778893, 5534.667919924817, 5535.6955367454775, 5537.446255374471, 6027.186329845415, 6027.547933904974, 6028.638281703112, 6032.758689652453, 6035.517158627299, 5740.512056475163, 5853.824385268449, 5862.296524417012, 5917.733701983421, 5959.612625179349, 5942.673152976541, 5949.8215053548465, 5952.702364881825, 5958.344582095966, 5970.492508136857, 5779.826605201851, 5871.3541510433815, 5908.409159084057, 5912.822615321547, 5919.230500034968, 5854.268216472941, 5896.292444906553, 5915.260592425947, 5944.048952167633, 5961.225040744675, 4529.365888775574, 4533.863984080483, 4534.478534968521, 4537.659675524349, 4562.9771851141195, 4010.8997275068355, 4039.2123535910214, 4074.4499492568716, 4084.264832330209, 4098.938515922264, 5695.202671625976, 5714.714264286769, 5720.628159169641, 5724.341700704389, 5743.0, 6000.429959153874, 6049.122877182784, 6049.364816694272, 6053.51571874249, 6056.0, 5505.917411238835, 5585.1901474286005, 5722.7424765885635, 5727.284089488814, 5814.331351894586, 5145.897082058338, 5158.484151584811, 5171.3535808024, 5176.585873130216, 5182.53357197854, 6235.594686345464, 6235.688215589294, 6235.96882015587, 6237.906431403532, 6240.438360547572, 5954.493868021266, 5957.523398128226, 6037.547183961308, 6060.515158787374, 6068.423499767515, 6154.794268645956, 6188.752449901954, 6189.566730328834, 6194.287656919512, 6197.411245931629, 5711.828645140652, 5876.118582212703, 5876.911846322223, 5879.823605291848, 5919.881602367843, 5913.556483263858, 5987.13186587951, 5992.700364981821, 6018.525461262019, 6036.245469316335, 5861.267341582302, 5877.059670452707, 5892.234009578728, 5897.085951677325, 5902.20320256777, 5692.743826527733, 5812.709364531672, 5859.882802344015, 5871.941280587311, 5882.970585147047, 5710.343310519177, 5737.942620573741, 5747.798827041033, 5750.539956803362, 5779.190913272229, 5844.298684157929, 5855.473007429352, 5860.0, 5860.824175274749, 5865.677387743715, 5653.321601407857, 5736.0, 5756.079027355603, 5757.740901659352, 5771.105478650816], "value": 5518.27819164217, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.9934200657989, 660.2110477978817, 664.31243662809, 671.3152584363949, 734.4858598980713, 39938.60061399389, 40607.79696101523, 40656.59343406565, 40701.0, 40718.0, 42913.35629965553, 43543.56456435443, 43551.78224108875, 43575.34636980448, 43581.56418435815, 8060.113387527367, 8206.179382061806, 8762.518061506631, 8990.325725570576, 10342.948285258562, 10325.58697652093, 10454.947725261402, 10464.05823475887, 10466.581336746522, 10469.790604187912, 10459.320144190604, 10500.579976800918, 10534.683959481228, 10568.365898046104, 10574.471276436187, 8351.0, 10750.247482676215, 11012.284201526874, 11023.118150547936, 11034.889651103467, 10315.07164355204, 10456.111230545413, 10460.633877814316, 10466.319689220252, 10466.372017678963, 38867.0, 39243.21513569712, 39302.606973930466, 39307.803460982796, 39316.41025384622, 3704.9259014819822, 3744.101415660249, 3829.100161462054, 4013.25754735372, 4465.062336909253, 33458.33083338344, 33842.83078584616, 33891.15272118192, 33895.49156762651, 34284.314313713585, 4106.404571337169, 4135.0, 4289.378040184187, 4337.804798784031, 4393.967417656848, 308306.0, 308403.0, 309202.0, 309442.4527877369, 310488.0, 38560.42159367612, 63100.36899630945, 64137.67931160314, 64182.0, 64218.67890660517, 37303.0, 37618.62381376206, 37630.247395052495, 37651.24697506035, 37669.24661506809, 15955.122468264124, 16689.6662066758, 16928.238229279712, 16947.406840760515, 16950.0, 14476.855231447762, 14811.925940370229, 14819.110853348833, 14829.925850370679, 14838.258087095603, 9210.677626283183, 9281.628734850665, 9306.302027347976, 9369.812603747887, 9384.5307734613, 3452.4130897747445, 3549.600844100222, 3575.8927232183078, 3586.6413358663926, 3611.4041183205004, 1018.251585084962, 1165.0, 1225.136278923357, 1250.5060501102014, 1273.802560603108, 33108.66891331104, 33224.0, 34263.82868085644, 34309.142271443416, 34391.484127738106, 1170.3329102411544, 1184.5439505790162, 1244.0545185658964, 1248.712796056912, 1362.3256488038287, 16311.836881631269, 16424.589385265226, 16677.666446671, 16771.748423773653, 17114.48656540306, 492582.0, 498433.0, 498772.0, 499775.0, 502023.0, 61009.0, 61719.38280617226, 61733.0, 61844.381556183864, 61868.69065654643, 1416.6458385403648, 1417.7660685986903, 1516.9696606067816, 1618.037267825642, 1622.1483721046545, 30079.849600751855, 33360.833195834835, 33641.872012227774, 33728.0, 33756.49365259474, 58129.41870581409, 59891.0, 59941.700291498266, 60005.0, 60102.39897601143, 417822.0, 428586.0, 429643.0, 429988.0, 430180.0, 39254.4111838317, 46274.768626158, 46315.536844631126, 46494.76752616351, 47463.28805067857, 44927.10145797131, 45141.32288015616, 45942.31086533638, 46412.767936160104, 46653.533464666274, 36255.0, 38701.62795572298, 41177.38233926553, 41715.58284417117, 42459.1508169841, 40609.984750381474, 41130.38304425376, 41573.0, 41631.58368416277, 42725.57274427216, 43004.56995430006, 47712.761436193985, 48118.278225827344, 48574.75712621414, 49202.75398623127, 41766.0, 43349.41454093779, 44448.33327500155, 44783.0, 44918.77540612276, 33725.15687107842, 35076.29847403089, 35102.89944233865, 36001.81999089988, 38155.0], "value": 20360.27758758646, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.7738098807633, 427.207530031791, 430.898738796383, 439.2225760404085, 440.7906244533846, 18651.533711657215, 18745.0, 19045.80954190458, 19189.04054797258, 19399.22403103876, 17922.462326130237, 18468.90765546174, 19448.222071117172, 19593.412197634094, 19610.901945490252, 5703.458171473703, 5708.4862362387275, 5864.472197502224, 5865.8826823463505, 5879.265091863517, 4295.2912769393015, 5748.971255143719, 5777.797777077803, 6181.350958149397, 6492.285848556655, 6423.325550817167, 6434.453071488929, 6452.580582262161, 6464.709088091024, 6467.450266727334, 5488.506034456898, 5739.540836733051, 5748.109043098348, 5752.539796816244, 6384.201974753156, 3861.826217820205, 5409.864753381197, 5590.748416321276, 5619.803306884281, 5664.518515926151, 13551.728965420636, 13674.453021879113, 13783.793243101361, 13789.931050344683, 20438.79561204384, 2381.3927448500694, 2413.8310318277727, 2426.8058555315533, 2447.6206188040883, 3000.6249218847643, 9019.864702029476, 9742.561584728704, 9794.412335259836, 9911.752206194831, 10100.23245931959, 1897.6109897471124, 1942.291063761731, 1993.4418362858423, 2066.1528773203063, 2074.263636409083, 75983.0, 83903.99999999939, 85366.0, 86046.0, 86530.13469865284, 10785.838212426663, 11323.377214253294, 11410.828837567444, 11486.94256528712, 11514.136439766884, 15926.203689815695, 16137.35450581987, 16164.272607732444, 16165.757513637305, 16171.110588917723, 8594.44136131162, 8755.474671519729, 8797.164269394398, 8831.072737362612, 9042.367034307666, 8426.283765879969, 8474.5339006354, 8494.277986371104, 8508.489490630458, 8585.570721463902, 4725.149473094807, 4891.682040667345, 4960.305557221992, 5012.373453318335, 5113.769880355393, 1811.499726946693, 1998.430447322506, 2023.3727544461265, 2047.2732180076157, 2122.883241421706, 981.6417007792104, 1040.566210860976, 1098.7692584557174, 1099.8460215569826, 1183.946722397477, 16250.024998499892, 18504.074796260134, 18565.16456759422, 18874.62250754977, 18955.0, 1065.840123981409, 1090.2858627598935, 1100.2078503477483, 1109.1182509904645, 1113.092829344082, 10557.47212639365, 10598.152147828156, 10660.0, 10756.0, 10809.729756755987, 449271.0, 454663.0, 479399.6030019897, 483260.5836970793, 486901.0, 59281.40718592759, 60948.0, 62017.37982620116, 66453.66773166103, 91368.54315728378, 1174.3893175548837, 1175.1010476985114, 1194.820776883457, 1209.2623499665197, 1217.3183017510223, 17143.539812436673, 17486.387976421272, 17501.47495575135, 17671.64656706833, 17676.2045707946, 38455.61544384521, 38882.0, 41726.374104387854, 42273.0, 42286.7885660582, 60358.698206508685, 64026.67986660037, 64427.67786161039, 64663.030054548275, 64706.35293647003, 8781.121887811169, 8845.778855528406, 8861.669683370163, 9021.548922553715, 9113.681021164493, 12224.938875305923, 12719.93640031794, 12990.285534295705, 13485.460581576626, 13497.122687025312, 11682.649520514398, 11718.824217636913, 11722.062235021349, 11781.469833857669, 11859.703507412383, 10765.838512422477, 10865.456727163768, 10957.890421095686, 11008.944955275172, 11234.382108984084, 11431.42842857837, 11952.64142075739, 11981.820272696092, 12063.0, 12152.75694486123, 8835.469871807712, 8883.207230240949, 8945.865812012955, 9003.414778039407, 9015.954920225357, 10999.505022273857, 12325.938370308091, 12328.383580820744, 12343.75312493763, 12619.242845429304], "value": 9270.585363199605, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.6383404148962, 1580.1546172797553, 1599.6560739441022, 1782.509809802305, 1903.4765439504135, 8030.116687164407, 8099.311558517526, 8108.148644392328, 8121.309688676462, 8127.024757029165, 7996.92003079969, 8172.754817355489, 8182.713605023825, 8185.959070204641, 8191.180881911806, 2165.32874808809, 2216.468047668556, 2377.809775217987, 2403.4111642647576, 2429.975700242993, 2427.8664673442954, 2435.025989604155, 2435.147698305597, 2436.9512609747794, 2439.146298795425, 2356.304890057437, 2388.1402695029774, 2431.294924471901, 2432.20953190213, 2435.7807797298237, 2123.3311506875284, 2330.6620540021686, 2370.2059809963685, 2371.336025912747, 2372.8220383471307, 2344.695189625355, 2359.197872723282, 2386.642003699442, 2390.8326417150806, 2391.8804059797117, 8113.7565873023905, 8144.5113293202, 8147.266745992889, 8157.143499932481, 8199.836003279901, 5191.506806853343, 5269.525742683177, 5271.892902490444, 5305.787768489295, 5310.7610157543, 3585.928281434383, 3605.6394360563736, 3672.7429079964413, 3678.7240956928335, 3695.611960744137, 1105.9889401105966, 1120.8374785656115, 1137.5677242647741, 1138.3226979947, 1149.1151813103947, 11777.999999999915, 11817.290962542189, 11895.167338286323, 11918.821217681741, 11928.46321915516, 4682.929756053662, 4745.2882067690125, 4779.856604301876, 4817.421909370898, 4830.66185367028, 10095.44475053879, 10130.594776209016, 10173.28786984904, 10182.439965801952, 10195.898041019494, 5404.054290499147, 5410.3507579090765, 5413.7834486620095, 5414.83755487336, 5418.458154184629, 4374.12517496502, 4776.904461910812, 4870.366852309177, 4871.123197824355, 4881.51184881509, 3931.6461518463475, 4020.3165461871554, 4027.6576490998596, 4055.209234199303, 4066.4916885389325, 1323.0672375975107, 1350.1763924006348, 1355.606874006527, 1357.4163109862657, 1374.896882733799, 989.5101924547395, 995.4375777685584, 1019.0166489337824, 1023.5036007536339, 1033.3076838518211, 5910.881782364415, 5959.64242145464, 6140.0, 6142.262928448526, 6179.69101544921, 476.24039656748124, 478.9257665061921, 490.45069522135435, 492.3574734970826, 498.50647858619703, 4237.279662457389, 4246.660267178619, 4255.553166917491, 4257.808398622069, 4259.7231179973205, 9916.454594997344, 10232.334898231591, 10381.273310868166, 10409.68770936873, 10435.0, 10113.29206955506, 10156.23828212887, 10248.590056397661, 10255.846162307571, 10264.384136951807, 7506.174320824705, 7797.064352277763, 7983.880241796378, 8055.113937466874, 8063.072746634095, 5985.25184351956, 6013.338532761481, 6018.067199584071, 6137.7851775187655, 6156.722947467285, 8872.556372181236, 8898.822023559622, 9167.0, 9199.448033118035, 9233.815323693623, 9040.68357607507, 9315.627374904929, 9439.811203776024, 9444.527773611155, 9454.480003599869, 6739.831504212434, 7202.603856787927, 7338.559686418832, 7393.223711510214, 7609.086909570666, 8051.758447246592, 8106.270435660819, 8124.22819832115, 8143.714969976022, 8160.0, 7211.747588834365, 7358.227386124594, 7505.662245199088, 7582.507137036075, 7624.0, 7177.318154775288, 7188.101487314086, 7220.205777364381, 7247.166575843846, 7330.560166389821, 6789.830254243486, 6794.388505034571, 6833.282505337067, 6844.041834143323, 6844.555103918229, 5157.200633901752, 5212.478752124757, 5282.366116066097, 5315.149576067965, 5383.246345511553, 5147.305113809737, 5269.288646032736, 5270.89458210826, 5273.630845840754, 5464.071107911744], "value": 4519.140769514749, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.70995783457573, 362.9328574213772, 364.61715199041, 366.6864830569863, 367.5864652266199, 6340.239171299445, 6382.361763823621, 6472.611643301405, 6481.546291759579, 6495.772647957322, 6027.156198132265, 6327.462165715908, 6348.619082855021, 6350.174477317943, 6362.395572420613, 4725.645576581753, 4755.595774359166, 4775.522447755231, 4777.593904518103, 4789.568938795508, 4737.265723812798, 4767.9284810727695, 4773.260144677581, 4778.163821331271, 4790.880227994293, 4622.075584883037, 4725.810967561293, 4734.715917044971, 4784.521547845223, 4794.904101917959, 4658.138244424776, 4759.7620118994255, 4760.595349395306, 4771.594414474774, 4790.185668436392, 4233.1322078973735, 4244.957550424518, 4254.510731265913, 4255.127698821734, 4272.4445822042935, 6062.696865156725, 6065.423784740443, 6073.119397687311, 6078.057901025348, 6078.088286757022, 5629.915551266734, 5661.575381846378, 5661.886762264773, 5662.405447428002, 5665.49010589049, 6503.0, 6674.733010679615, 6677.599344039373, 6686.699098540577, 6695.966520167417, 4653.278741795028, 4658.697184682985, 4673.532646735333, 4675.158471475133, 4680.882977925545, 6942.201646810631, 7007.684654190573, 7016.298370162943, 7019.298070192991, 7023.92976070243, 4745.406824146981, 4751.809927602857, 4751.95248047522, 4756.9286460703115, 4760.190767569521, 4812.0, 4814.855554333376, 4815.470298267188, 4815.927761083586, 4816.036792641486, 5550.47270509301, 5559.27729395176, 5561.277033985637, 5561.860953476195, 5571.4150014248735, 6584.5061620378665, 6746.291639377795, 6752.898706519406, 6756.425703815133, 6761.154855643044, 1673.322304466693, 1696.881218314706, 1700.4898530440819, 1702.761613374104, 1703.693335199651, 1055.9102476289602, 1107.3355986408092, 1112.8386383974441, 1131.4329653429895, 1136.3693150301497, 6494.285628580852, 6495.025746138117, 6501.934980650228, 6503.0, 6542.051402546604, 6917.827054323682, 6918.965405172942, 6923.549969252083, 6926.307369263134, 6938.924466707668, 6489.837754056092, 6491.058796474485, 6492.415682588589, 6493.090967264587, 6495.545311828127, 3730.421784623388, 3762.5108735864164, 3762.887113386603, 3763.6800871925643, 3768.3217020936495, 7088.468364872655, 7240.601766902871, 7249.383802376857, 7277.345038946414, 7352.5956072415465, 7122.5726456412785, 7151.0, 7167.247439018932, 7169.354758071799, 7170.426365890717, 7308.415326773846, 7310.4517161213125, 7313.67088481009, 7319.048523691992, 7323.560586364835, 6889.311068893071, 7048.471364647569, 7051.823704407431, 7061.576305421691, 7061.894071589033, 6919.965400173169, 6923.723051077901, 6927.168739751262, 6928.064711264116, 6929.480288978246, 7247.021652076902, 7283.089613798275, 7287.194430144326, 7289.45329100309, 7296.087989001375, 4796.95203047979, 4831.830885918976, 4833.879153021203, 4837.4920633332995, 4841.080194762983, 7020.473464490082, 7021.859562808818, 7025.68384422692, 7027.824304392431, 7029.929700702927, 6654.700538475877, 6838.931610684029, 6839.31606839332, 6839.384455399038, 6855.0, 6751.898721519279, 6786.728530858711, 6797.490188236001, 6804.353586409283, 6805.081314022544, 6693.397594216543, 6698.66506674674, 6707.798766037026, 6709.765158219634, 6714.496412768965, 6659.600423974577, 6859.416949559144, 6859.7256109757045, 6864.759733409307, 6874.312568743086, 6464.709088091141, 6564.901526477011, 6668.066470694203, 6682.2649508555, 6699.5310328276555], "value": 5085.769951916089, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.1581923161449, 826.7809030606886, 892.4110087342353, 899.123354729139, 912.3112050401945, 14813.777793333094, 15009.474668386609, 15230.847691523095, 15264.771028434583, 15277.388904443837, 14309.57071287863, 14335.139891606512, 14390.352434140463, 14390.712185756278, 14391.136531808099, 723.1105739939891, 877.8376000439939, 901.2294488212549, 901.5221932375852, 904.6426661468716, 888.2006194425037, 896.3277541843618, 897.2687259883174, 897.7979954510248, 898.6405437824857, 942.2979879989417, 944.0323668240075, 944.1361154543584, 944.1785646487531, 945.121037435185, 774.1948373691354, 942.241495596045, 953.5280036382036, 955.1499165742425, 955.7945041816008, 703.8134894252976, 704.0741425026074, 704.1514974455769, 704.3203308807026, 704.5526090932244, 14294.142351458946, 14326.212058336787, 14370.784438233435, 14383.065100768417, 14384.928075359661, 13937.651558711012, 14073.788893166611, 14275.928620356935, 14630.122192668474, 14650.487232946902, 11339.659810205625, 11490.138239631977, 11659.12556558253, 11759.470823812864, 11965.401729913556, 4000.0, 4035.25347810653, 4070.8575199867864, 4131.752094874317, 4158.064435501988, 56102.43897561013, 56275.0, 56369.71815140939, 56818.715906420206, 56878.71560642212, 11312.484781020583, 11694.590689325832, 11696.298222106701, 11718.941405292919, 11866.703332416586, 19679.60640787205, 19744.40766776999, 19834.404967850987, 19871.105800239024, 19942.302019429542, 8613.440126391764, 8635.525046122399, 8734.650613975497, 8786.297096232285, 8980.012198658142, 4728.148933192058, 4985.376827896513, 5193.221016847428, 5197.246399272084, 5246.895062098737, 3589.5333606631493, 3631.2737452509605, 3633.5821380541574, 3639.6178401268016, 3646.9452958205648, 699.7655785311875, 705.4215543254585, 708.6952610377588, 710.0378986473357, 722.3282347416848, 745.4520927118564, 788.1960400391569, 800.7669877351595, 803.1727320859524, 819.663937785505, 10030.29787914839, 10158.339707918962, 10197.898021019842, 10240.436775977392, 10315.535800888978, 733.6258508160877, 804.7891877462387, 820.1306614988013, 840.1850205300971, 849.482083560497, 4732.337472753818, 4738.976305118453, 4751.619870410359, 4800.975995120002, 4834.0, 67205.32794672088, 68316.0, 69719.3028069723, 70399.29600704029, 70939.2906070943, 58948.0, 59838.0, 59939.700301499084, 60126.398736012954, 60738.0, 54642.72678636581, 54728.45271547313, 55214.72392638011, 55414.0, 55849.0, 9331.393459425115, 9424.57589408492, 9485.383450075724, 9568.56941437623, 9598.520073996411, 40444.0, 40835.38746918858, 41400.79299603483, 41502.584974149875, 42656.36015459709, 52782.736086319324, 53515.73242133764, 53829.730851347056, 53976.46023539714, 54794.45205548053, 11857.11071669611, 11883.346415947206, 11892.464839082435, 12035.45840437165, 12371.505139794308, 11195.552177912792, 12635.747285054063, 13099.409375233405, 13201.933990329986, 13244.337783110614, 13046.347682615642, 13060.281684507443, 13175.14361566495, 13197.142185757895, 13443.991700622297, 13707.931460342634, 13719.0, 13833.239171845646, 13918.51285205013, 14127.576172714835, 13017.974277164529, 13119.212847229197, 13625.197446770375, 13659.86340136586, 13767.862321376659, 10895.0, 11138.777224455303, 11159.776804463703, 11518.308901465938, 11689.240199387013, 11296.894199819988, 11498.0, 11683.766324673288, 11688.532458701557, 11801.645950621494], "value": 7253.074047165922, "unit": "score"}], "name": "dromaeo_css", "value": 7469.268735085463, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 110.0, 111.0, 110.0, 111.0, 106.0, 110.0, 110.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 146.0, 164.0, 181.0, 126.0, 159.0, 152.0, 129.0, 191.0, 131.0], "value": 153.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 162.0, 160.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 77.0, 173.0, 72.0, 76.0, 76.0, 74.0, 184.0, 76.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 151.0, 92.0, 92.0, 92.0, 150.0, 93.0, 93.0, 152.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 54.0, 55.0, 55.0, 57.0, 73.0, 53.0, 55.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 58.0, 58.0, 59.0, 59.0, 58.0, 58.0, 59.0, 58.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 72.0, 81.0, 72.0, 74.0, 73.0, 74.0, 74.0, 73.0, 82.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 122.0, 116.0, 123.0, 110.0, 116.0, 120.0, 111.0, 131.0, 139.0], "value": 120.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 158.0, 158.0, 164.0, 160.0, 160.0, 157.0, 158.0, 155.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 64.0, 65.0, 67.0, 65.0, 67.0, 67.0, 64.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1522.9, "alertThreshold": 2.0}]} 03:47:11 INFO - Return code: 0 03:47:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:47:11 ERROR - # TBPL SUCCESS # 03:47:11 INFO - Running post-action listener: _resource_record_post_action 03:47:11 INFO - Running post-run listener: _resource_record_post_run 03:47:12 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 500740096; Read time: 16; Write time: 340428 03:47:12 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 218005504; Read time: 0; Write time: 191728 03:47:12 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252137472; Read time: 16; Write time: 141832 03:47:12 INFO - Running post-run listener: _upload_blobber_files 03:47:12 INFO - Blob upload gear active. 03:47:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:47:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:47:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:47:12 INFO - (blobuploader) - INFO - Open directory for files ... 03:47:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:47:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:47:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:13 INFO - (blobuploader) - INFO - Done attempting. 03:47:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:47:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:47:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:14 INFO - (blobuploader) - INFO - Done attempting. 03:47:14 INFO - (blobuploader) - INFO - Iteration through files over. 03:47:14 INFO - Return code: 0 03:47:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:47:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:47:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26d39157394684dc6022f5e142577a617bfa03cbaa55f599ce0dd2e5a1a301fbcb9467ba98fb7b30d8c20412ff83ea18511890cdad8dfc7260b6bcac4e409219", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c9f94d96056e588f600887c33b68c8f0a8e03a3a37bf2e2cd28123e0e3045d14ce2acc223584638ab2e9664e31fab21791b9d628410d993c3d5ec8bcbee429b"} 03:47:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:47:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:47:14 INFO - Contents: 03:47:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26d39157394684dc6022f5e142577a617bfa03cbaa55f599ce0dd2e5a1a301fbcb9467ba98fb7b30d8c20412ff83ea18511890cdad8dfc7260b6bcac4e409219", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c9f94d96056e588f600887c33b68c8f0a8e03a3a37bf2e2cd28123e0e3045d14ce2acc223584638ab2e9664e31fab21791b9d628410d993c3d5ec8bcbee429b"} 03:47:14 INFO - Running post-run listener: copy_logs_to_upload_dir 03:47:14 INFO - Copying logs to upload dir... 03:47:14 INFO - mkdir: /builds/slave/test/build/upload/logs 03:47:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.410660 ========= master_lag: 0.61 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-07 03:47:14.884314) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-07 03:47:14.888902) ========= 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=00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894 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/26d39157394684dc6022f5e142577a617bfa03cbaa55f599ce0dd2e5a1a301fbcb9467ba98fb7b30d8c20412ff83ea18511890cdad8dfc7260b6bcac4e409219", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c9f94d96056e588f600887c33b68c8f0a8e03a3a37bf2e2cd28123e0e3045d14ce2acc223584638ab2e9664e31fab21791b9d628410d993c3d5ec8bcbee429b"} build_url:https://queue.taskcluster.net/v1/task/WB7E19M5S1imq8YNzfU8mg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/WB7E19M5S1imq8YNzfU8mg/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/26d39157394684dc6022f5e142577a617bfa03cbaa55f599ce0dd2e5a1a301fbcb9467ba98fb7b30d8c20412ff83ea18511890cdad8dfc7260b6bcac4e409219", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c9f94d96056e588f600887c33b68c8f0a8e03a3a37bf2e2cd28123e0e3045d14ce2acc223584638ab2e9664e31fab21791b9d628410d993c3d5ec8bcbee429b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-07 03:47:14.916616) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 03:47:14.917004) ========= 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=00204705a9daa57ed339a427000001b9-1462615350.13373-1696885894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-07 03:47:14.966382) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-07 03:47:14.969827) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-07 03:47:14.970224) ========= ========= Total master_lag: 0.74 =========