builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1464430267.55 results: success (0) buildid: 20160525152143 builduid: 8654ccbbea454f27b451ee4808dca30e revision: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:07.555240) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:07.555813) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:07.556223) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:07.569032) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:07.569393) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-28 03:11:07-- 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% 38.1M=0s 2016-05-28 03:11:07 (38.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.266991 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:07.848641) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:07.848991) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016786 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:07.898749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:07.899478) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 --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 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 --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=9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-28 03:11:08,010 truncating revision to first 12 chars 2016-05-28 03:11:08,010 Setting DEBUG logging. 2016-05-28 03:11:08,010 attempt 1/10 2016-05-28 03:11:08,010 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4f7c3a2567f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 03:11:08,627 unpacking tar archive at: mozilla-aurora-4f7c3a2567f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.946470 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:08.862004) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:08.862530) ========= script_repo_revision: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:08.863013) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:08.863484) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:08.873279) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-28 03:11:08.873579) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:11:09 INFO - MultiFileLogger online at 20160528 03:11:09 in /builds/slave/test 03:11:09 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:11:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:11:09 INFO - {'append_to_log': False, 03:11:09 INFO - 'base_work_dir': '/builds/slave/test', 03:11:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:11:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:11:09 INFO - 'branch': 'Mozilla-Aurora', 03:11:09 INFO - 'buildbot_json_path': 'buildprops.json', 03:11:09 INFO - 'config_files': ('talos/linux_config.py',), 03:11:09 INFO - 'default_actions': ('clobber', 03:11:09 INFO - 'read-buildbot-config', 03:11:09 INFO - 'download-and-extract', 03:11:09 INFO - 'populate-webroot', 03:11:09 INFO - 'create-virtualenv', 03:11:09 INFO - 'install', 03:11:09 INFO - 'run-tests'), 03:11:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:11:09 INFO - 'download_minidump_stackwalk': True, 03:11:09 INFO - 'download_symbols': 'ondemand', 03:11:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:11:09 INFO - 'tooltool.py': '/tools/tooltool.py', 03:11:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:11:09 INFO - '/tools/misc-python/virtualenv.py')}, 03:11:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:11:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:11:09 INFO - 'installer_path': 'installer.exe', 03:11:09 INFO - 'log_level': 'info', 03:11:09 INFO - 'log_name': 'talos', 03:11:09 INFO - 'log_to_console': True, 03:11:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:11:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:11:09 INFO - 'opt_config_files': (), 03:11:09 INFO - 'pip_index': False, 03:11:09 INFO - 'sps_profile': False, 03:11:09 INFO - 'sps_profile_interval': 0, 03:11:09 INFO - 'suite': 'dromaeojs', 03:11:09 INFO - 'system_bits': '32', 03:11:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:11:09 INFO - 'title': 'talos-linux64-ix-040', 03:11:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:11:09 INFO - 'use_talos_json': True, 03:11:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:11:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:11:09 INFO - 'work_dir': 'build'} 03:11:09 INFO - ##### 03:11:09 INFO - ##### Running clobber step. 03:11:09 INFO - ##### 03:11:09 INFO - Running pre-action listener: _resource_record_pre_action 03:11:09 INFO - Running main action method: clobber 03:11:09 INFO - rmtree: /builds/slave/test/build 03:11:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:11:09 INFO - Running post-action listener: _resource_record_post_action 03:11:09 INFO - ##### 03:11:09 INFO - ##### Running read-buildbot-config step. 03:11:09 INFO - ##### 03:11:09 INFO - Running pre-action listener: _resource_record_pre_action 03:11:09 INFO - Running main action method: read_buildbot_config 03:11:09 INFO - Using buildbot properties: 03:11:09 INFO - { 03:11:09 INFO - "project": "", 03:11:09 INFO - "product": "firefox", 03:11:09 INFO - "script_repo_revision": "production", 03:11:09 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:11:09 INFO - "repository": "", 03:11:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:11:09 INFO - "buildid": "20160525152143", 03:11:09 INFO - "pgo_build": "True", 03:11:09 INFO - "basedir": "/builds/slave/test", 03:11:09 INFO - "buildnumber": 524, 03:11:09 INFO - "slavename": "talos-linux64-ix-040", 03:11:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:11:09 INFO - "platform": "ubuntu64_hw", 03:11:09 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:11:09 INFO - "branch": "mozilla-aurora", 03:11:09 INFO - "repo_path": "releases/mozilla-aurora", 03:11:09 INFO - "revision": "4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3", 03:11:09 INFO - "stage_platform": "linux64-pgo", 03:11:09 INFO - "builduid": "8654ccbbea454f27b451ee4808dca30e", 03:11:09 INFO - "slavebuilddir": "test" 03:11:09 INFO - } 03:11:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:11:09 INFO - Running post-action listener: _resource_record_post_action 03:11:09 INFO - ##### 03:11:09 INFO - ##### Running download-and-extract step. 03:11:09 INFO - ##### 03:11:09 INFO - Running pre-action listener: _resource_record_pre_action 03:11:09 INFO - Running main action method: download_and_extract 03:11:09 INFO - mkdir: /builds/slave/test/build/tests 03:11: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:11:09 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:11:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:11:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:11:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:12 INFO - Downloaded 1361 bytes. 03:11:12 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:11:12 INFO - Using the following test package requirements: 03:11:12 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:11:12 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:11:12 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:11:12 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:12 INFO - u'jsshell-linux-x86_64.zip'], 03:11:12 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:11:12 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:11:12 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:11:12 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:11:12 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:11:12 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:11:12 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:12 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:11:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:13 INFO - Downloaded 24135950 bytes. 03:11:13 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:11:13 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:11:15 INFO - Return code: 0 03:11:15 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:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:15 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:11:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:19 INFO - Downloaded 24135950 bytes. 03:11:19 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:11:19 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:11:20 INFO - Return code: 0 03:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:20 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:21 INFO - Downloaded 10840145 bytes. 03:11:21 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:11:21 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:11:21 INFO - Return code: 0 03:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:21 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:11:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:11:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:11:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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:11:23 INFO - Downloaded 62768089 bytes. 03:11:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:11:23 INFO - mkdir: /builds/slave/test/properties 03:11:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:11:23 INFO - Writing to file /builds/slave/test/properties/build_url 03:11:23 INFO - Contents: 03:11:23 INFO - build_url:https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:11:23 INFO - Running post-action listener: _resource_record_post_action 03:11:23 INFO - Running post-action listener: set_extra_try_arguments 03:11:23 INFO - ##### 03:11:23 INFO - ##### Running populate-webroot step. 03:11:23 INFO - ##### 03:11:23 INFO - Running pre-action listener: _resource_record_pre_action 03:11:23 INFO - Running main action method: populate_webroot 03:11:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:11:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:11:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:11:23 INFO - '--tppagecycles', 03:11:23 INFO - '7'], 03:11:23 INFO - 'tests': ['tsvgm']}}, 03:11:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:11:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:11:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:11:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:11:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:11:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:11:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:23 INFO - 'talos_options': ['--disable-e10s'], 03:11:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:23 INFO - 'talos_options': ['--disable-e10s'], 03:11:23 INFO - 'tests': ['damp', 'tps']}, 03:11:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:23 INFO - 'tests': ['damp', 'tps']}, 03:11:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:11:23 INFO - 'tests': ['dromaeo_dom']}, 03:11:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:11:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:11:23 INFO - 'tests': ['a11yr', 03:11:23 INFO - 'ts_paint', 03:11:23 INFO - 'tpaint', 03:11:23 INFO - 'sessionrestore', 03:11:23 INFO - 'sessionrestore_no_auto_restore', 03:11:23 INFO - 'tabpaint']}, 03:11:23 INFO - 'other-e10s': {'tests': ['a11yr', 03:11:23 INFO - 'ts_paint', 03:11:23 INFO - 'tpaint', 03:11:23 INFO - 'sessionrestore', 03:11:23 INFO - 'sessionrestore_no_auto_restore', 03:11:23 INFO - 'tabpaint']}, 03:11:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:11:23 INFO - 'ts_paint', 03:11:23 INFO - 'tpaint', 03:11:23 INFO - 'sessionrestore', 03:11:23 INFO - 'sessionrestore_no_auto_restore', 03:11:23 INFO - 'tabpaint']}, 03:11:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:11:23 INFO - 'ts_paint', 03:11:23 INFO - 'tpaint', 03:11:23 INFO - 'sessionrestore', 03:11:23 INFO - 'sessionrestore_no_auto_restore', 03:11:23 INFO - 'tabpaint']}, 03:11:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:11:23 INFO - 'tests': ['a11yr', 03:11:23 INFO - 'ts_paint', 03:11:23 INFO - 'tpaint', 03:11:23 INFO - 'sessionrestore', 03:11:23 INFO - 'sessionrestore_no_auto_restore', 03:11:23 INFO - 'tabpaint']}, 03:11:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:11:23 INFO - 'tests': ['a11yr', 03:11:23 INFO - 'ts_paint', 03:11:23 INFO - 'tpaint', 03:11:23 INFO - 'sessionrestore', 03:11:23 INFO - 'sessionrestore_no_auto_restore', 03:11:23 INFO - 'tabpaint']}, 03:11:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:11:23 INFO - 'tests': ['tsvgx', 03:11:23 INFO - 'tsvgr_opacity', 03:11:23 INFO - 'tart', 03:11:23 INFO - 'tscrollx', 03:11:23 INFO - 'cart']}, 03:11:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:11:23 INFO - 'tsvgr_opacity', 03:11:23 INFO - 'tart', 03:11:23 INFO - 'tscrollx', 03:11:23 INFO - 'cart']}, 03:11:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:23 INFO - 'talos_options': ['--disable-e10s'], 03:11:23 INFO - 'tests': ['tp5o']}, 03:11:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:23 INFO - 'tests': ['tp5o']}, 03:11:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:23 INFO - 'talos_options': ['--disable-e10s', 03:11:23 INFO - '--xperf_path', 03:11:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:23 INFO - 'tests': ['tp5n']}, 03:11:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:23 INFO - 'talos_options': ['--xperf_path', 03:11:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:23 INFO - 'tests': ['tp5n']}}, 03:11:23 INFO - 'talos.zip': {'path': '', 03:11:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:11:23 INFO - Running post-action listener: _resource_record_post_action 03:11:23 INFO - ##### 03:11:23 INFO - ##### Running create-virtualenv step. 03:11:23 INFO - ##### 03:11:23 INFO - Running pre-action listener: _resource_record_pre_action 03:11:23 INFO - Running main action method: create_virtualenv 03:11:23 INFO - Creating virtualenv /builds/slave/test/build/venv 03:11:23 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:11:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:11:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:11:24 INFO - Using real prefix '/usr' 03:11:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:11:24 INFO - Installing distribute.............................................................................................................................................................................................done. 03:11:26 INFO - Installing pip.................done. 03:11:26 INFO - Return code: 0 03:11:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:11:26 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:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:26 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:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:26 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 0x7f5dee816f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1783410>, '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 0x1784310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17847a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', '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:11:26 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:11:26 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:11:26 INFO - Using env: {'DISPLAY': ':0', 03:11:26 INFO - 'HOME': '/home/cltbld', 03:11:26 INFO - 'LANG': 'en_US.UTF-8', 03:11:26 INFO - 'LANGUAGE': 'en_US:en', 03:11:26 INFO - 'LOGNAME': 'cltbld', 03:11:26 INFO - 'MAIL': '/var/mail/cltbld', 03:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:26 INFO - 'MOZ_NO_REMOTE': '1', 03:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:26 INFO - 'NO_EM_RESTART': '1', 03:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:26 INFO - 'PWD': '/builds/slave/test', 03:11:26 INFO - 'SHELL': '/bin/bash', 03:11:26 INFO - 'SHLVL': '1', 03:11:26 INFO - 'TERM': 'linux', 03:11:26 INFO - 'TMOUT': '86400', 03:11:26 INFO - 'USER': 'cltbld', 03:11:26 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', 03:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:26 INFO - '_': '/tools/buildbot/bin/python'} 03:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:26 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:11:26 INFO - Cleaning up... 03:11:26 INFO - Return code: 0 03:11:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:11:26 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:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:26 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:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:26 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 0x7f5dee816f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1783410>, '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 0x1784310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17847a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', '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:11:26 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:11:26 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:11:26 INFO - Using env: {'DISPLAY': ':0', 03:11:26 INFO - 'HOME': '/home/cltbld', 03:11:26 INFO - 'LANG': 'en_US.UTF-8', 03:11:26 INFO - 'LANGUAGE': 'en_US:en', 03:11:26 INFO - 'LOGNAME': 'cltbld', 03:11:26 INFO - 'MAIL': '/var/mail/cltbld', 03:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:26 INFO - 'MOZ_NO_REMOTE': '1', 03:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:26 INFO - 'NO_EM_RESTART': '1', 03:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:26 INFO - 'PWD': '/builds/slave/test', 03:11:26 INFO - 'SHELL': '/bin/bash', 03:11:26 INFO - 'SHLVL': '1', 03:11:26 INFO - 'TERM': 'linux', 03:11:26 INFO - 'TMOUT': '86400', 03:11:26 INFO - 'USER': 'cltbld', 03:11:26 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', 03:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:26 INFO - '_': '/tools/buildbot/bin/python'} 03:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:26 INFO - Downloading/unpacking psutil>=0.7.1 03:11:26 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:11:26 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:11:26 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:11:26 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:11:26 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:11:26 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:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:11:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:28 INFO - Installing collected packages: psutil 03:11:28 INFO - Running setup.py install for psutil 03:11:29 INFO - building 'psutil._psutil_linux' extension 03:11:29 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:11:29 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:11:29 INFO - building 'psutil._psutil_posix' extension 03:11:29 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:11:29 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:11:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:29 INFO - Successfully installed psutil 03:11:29 INFO - Cleaning up... 03:11:29 INFO - Return code: 0 03:11:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:11:29 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:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:29 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:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:29 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 0x7f5dee816f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1783410>, '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 0x1784310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17847a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', '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:11:29 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:11:29 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:11:29 INFO - Using env: {'DISPLAY': ':0', 03:11:29 INFO - 'HOME': '/home/cltbld', 03:11:29 INFO - 'LANG': 'en_US.UTF-8', 03:11:29 INFO - 'LANGUAGE': 'en_US:en', 03:11:29 INFO - 'LOGNAME': 'cltbld', 03:11:29 INFO - 'MAIL': '/var/mail/cltbld', 03:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:29 INFO - 'MOZ_NO_REMOTE': '1', 03:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:29 INFO - 'NO_EM_RESTART': '1', 03:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:29 INFO - 'PWD': '/builds/slave/test', 03:11:29 INFO - 'SHELL': '/bin/bash', 03:11:29 INFO - 'SHLVL': '1', 03:11:29 INFO - 'TERM': 'linux', 03:11:29 INFO - 'TMOUT': '86400', 03:11:29 INFO - 'USER': 'cltbld', 03:11:29 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', 03:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:29 INFO - '_': '/tools/buildbot/bin/python'} 03:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:11:31 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:11:31 INFO - Installing collected packages: mozsystemmonitor 03:11:31 INFO - Running setup.py install for mozsystemmonitor 03:11:31 INFO - Successfully installed mozsystemmonitor 03:11:31 INFO - Cleaning up... 03:11:31 INFO - Return code: 0 03:11:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5dee816f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1783410>, '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 0x1784310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17847a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', '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:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:11:31 INFO - Using env: {'DISPLAY': ':0', 03:11:31 INFO - 'HOME': '/home/cltbld', 03:11:31 INFO - 'LANG': 'en_US.UTF-8', 03:11:31 INFO - 'LANGUAGE': 'en_US:en', 03:11:31 INFO - 'LOGNAME': 'cltbld', 03:11:31 INFO - 'MAIL': '/var/mail/cltbld', 03:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:31 INFO - 'MOZ_NO_REMOTE': '1', 03:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:31 INFO - 'NO_EM_RESTART': '1', 03:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:31 INFO - 'PWD': '/builds/slave/test', 03:11:31 INFO - 'SHELL': '/bin/bash', 03:11:31 INFO - 'SHLVL': '1', 03:11:31 INFO - 'TERM': 'linux', 03:11:31 INFO - 'TMOUT': '86400', 03:11:31 INFO - 'USER': 'cltbld', 03:11:31 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', 03:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:31 INFO - '_': '/tools/buildbot/bin/python'} 03:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:31 INFO - Downloading/unpacking blobuploader==1.2.4 03:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:33 INFO - Downloading blobuploader-1.2.4.tar.gz 03:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:11:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:11:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:34 INFO - Downloading docopt-0.6.1.tar.gz 03:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:11:34 INFO - Installing collected packages: blobuploader, requests, docopt 03:11:34 INFO - Running setup.py install for blobuploader 03:11:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:11:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:11:34 INFO - Running setup.py install for requests 03:11:35 INFO - Running setup.py install for docopt 03:11:35 INFO - Successfully installed blobuploader requests docopt 03:11:35 INFO - Cleaning up... 03:11:35 INFO - Return code: 0 03:11:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11: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:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11: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:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:35 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 0x7f5dee816f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1783410>, '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 0x1784310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17847a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', '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:11:35 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:11:35 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:11:35 INFO - Using env: {'DISPLAY': ':0', 03:11:35 INFO - 'HOME': '/home/cltbld', 03:11:35 INFO - 'LANG': 'en_US.UTF-8', 03:11:35 INFO - 'LANGUAGE': 'en_US:en', 03:11:35 INFO - 'LOGNAME': 'cltbld', 03:11:35 INFO - 'MAIL': '/var/mail/cltbld', 03:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:35 INFO - 'MOZ_NO_REMOTE': '1', 03:11:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:35 INFO - 'NO_EM_RESTART': '1', 03:11:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:35 INFO - 'PWD': '/builds/slave/test', 03:11:35 INFO - 'SHELL': '/bin/bash', 03:11:35 INFO - 'SHLVL': '1', 03:11:35 INFO - 'TERM': 'linux', 03:11:35 INFO - 'TMOUT': '86400', 03:11:35 INFO - 'USER': 'cltbld', 03:11:35 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', 03:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:35 INFO - '_': '/tools/buildbot/bin/python'} 03:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:11:35 INFO - Running setup.py (path:/tmp/pip-hMcRXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:11:35 INFO - Running setup.py (path:/tmp/pip-QeetVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:11:35 INFO - Running setup.py (path:/tmp/pip-2P_wwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:11:35 INFO - Running setup.py (path:/tmp/pip-lnXkfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:11:35 INFO - Running setup.py (path:/tmp/pip-oXTSPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:11:35 INFO - Running setup.py (path:/tmp/pip-ydAFS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:11:35 INFO - Running setup.py (path:/tmp/pip-FCjaQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:11:35 INFO - Running setup.py (path:/tmp/pip-33MXoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:11:36 INFO - Running setup.py (path:/tmp/pip-88AR_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:11:36 INFO - Running setup.py (path:/tmp/pip-nqUcd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:11:36 INFO - Running setup.py (path:/tmp/pip-WSUcyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:11:36 INFO - Running setup.py (path:/tmp/pip-6yz1V1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:11:36 INFO - Running setup.py (path:/tmp/pip-9Of0Am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:11:36 INFO - Running setup.py (path:/tmp/pip-ZEIajM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:36 INFO - Running setup.py (path:/tmp/pip-OMep9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:11:36 INFO - Running setup.py (path:/tmp/pip-Ml_qg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:11:36 INFO - Running setup.py (path:/tmp/pip-em3_PY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:11:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:11:36 INFO - Running setup.py install for manifestparser 03:11:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:11:36 INFO - Running setup.py install for mozcrash 03:11:36 INFO - Running setup.py install for mozdebug 03:11:36 INFO - Running setup.py install for mozdevice 03:11:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:11:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:11:37 INFO - Running setup.py install for mozfile 03:11:37 INFO - Running setup.py install for mozhttpd 03:11:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:11:37 INFO - Running setup.py install for mozinfo 03:11:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:11:37 INFO - Running setup.py install for mozInstall 03:11:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:11:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:11:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:11:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:11:37 INFO - Running setup.py install for mozleak 03:11:37 INFO - Running setup.py install for mozlog 03:11:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:11:37 INFO - Running setup.py install for moznetwork 03:11:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:11:37 INFO - Running setup.py install for mozprocess 03:11:37 INFO - Running setup.py install for mozprofile 03:11:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:11:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:11:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:11:37 INFO - Running setup.py install for mozrunner 03:11:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:11:38 INFO - Running setup.py install for mozscreenshot 03:11:38 INFO - Running setup.py install for moztest 03:11:38 INFO - Running setup.py install for mozversion 03:11:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:11:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:11:38 INFO - Cleaning up... 03:11:38 INFO - Return code: 0 03:11:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11: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:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11: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:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:38 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 0x7f5dee816f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1783410>, '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 0x1784310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17847a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', '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:11:38 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:11:38 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:11:38 INFO - Using env: {'DISPLAY': ':0', 03:11:38 INFO - 'HOME': '/home/cltbld', 03:11:38 INFO - 'LANG': 'en_US.UTF-8', 03:11:38 INFO - 'LANGUAGE': 'en_US:en', 03:11:38 INFO - 'LOGNAME': 'cltbld', 03:11:38 INFO - 'MAIL': '/var/mail/cltbld', 03:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:38 INFO - 'MOZ_NO_REMOTE': '1', 03:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:38 INFO - 'NO_EM_RESTART': '1', 03:11:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:38 INFO - 'PWD': '/builds/slave/test', 03:11:38 INFO - 'SHELL': '/bin/bash', 03:11:38 INFO - 'SHLVL': '1', 03:11:38 INFO - 'TERM': 'linux', 03:11:38 INFO - 'TMOUT': '86400', 03:11:38 INFO - 'USER': 'cltbld', 03:11:38 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', 03:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:38 INFO - '_': '/tools/buildbot/bin/python'} 03:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:11:38 INFO - Running setup.py (path:/tmp/pip-l883qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:11:38 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:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:11:38 INFO - Running setup.py (path:/tmp/pip-L_fsK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:11:38 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:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:11:38 INFO - Running setup.py (path:/tmp/pip-mXSL5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:11:38 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:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:11:38 INFO - Running setup.py (path:/tmp/pip-uohGpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:11:38 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:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:11:38 INFO - Running setup.py (path:/tmp/pip-L_uIPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:11:38 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:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:11:38 INFO - Running setup.py (path:/tmp/pip-C0R5G3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:11:39 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:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:11:39 INFO - Running setup.py (path:/tmp/pip-78xg0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:11:39 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:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:11:39 INFO - Running setup.py (path:/tmp/pip-TYOyHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:11:39 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:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:11:39 INFO - Running setup.py (path:/tmp/pip-4qHaqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:11:39 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:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:11:39 INFO - Running setup.py (path:/tmp/pip-KESuKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:11:39 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:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:11:39 INFO - Running setup.py (path:/tmp/pip-z3geKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:11:39 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:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:11:39 INFO - Running setup.py (path:/tmp/pip-tJBSis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:11:39 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:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:11:39 INFO - Running setup.py (path:/tmp/pip-NK6Fsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:11:39 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:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:11:39 INFO - Running setup.py (path:/tmp/pip-9IrKhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:11:39 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:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:39 INFO - Running setup.py (path:/tmp/pip-oOL7n4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:39 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:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:11:39 INFO - Running setup.py (path:/tmp/pip-iDESDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:11:39 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:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:11:39 INFO - Running setup.py (path:/tmp/pip-NV1atU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:11:39 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:11:39 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:11:39 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:11:39 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:11:39 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:11:39 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:11:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:11:39 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:11:39 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:11:39 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:11:39 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:11:39 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:11:39 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:11:41 INFO - Downloading blessings-1.6.tar.gz 03:11:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:11:41 INFO - Installing collected packages: blessings 03:11:41 INFO - Running setup.py install for blessings 03:11:41 INFO - Successfully installed blessings 03:11:41 INFO - Cleaning up... 03:11:41 INFO - Return code: 0 03:11:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:11:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:11:42 INFO - Reading from file tmpfile_stdout 03:11:42 INFO - Current package versions: 03:11:42 INFO - argparse == 1.2.1 03:11:42 INFO - blessings == 1.6 03:11:42 INFO - blobuploader == 1.2.4 03:11:42 INFO - docopt == 0.6.1 03:11:42 INFO - manifestparser == 1.1 03:11:42 INFO - mozInstall == 1.12 03:11:42 INFO - mozcrash == 0.17 03:11:42 INFO - mozdebug == 0.1 03:11:42 INFO - mozdevice == 0.48 03:11:42 INFO - mozfile == 1.2 03:11:42 INFO - mozhttpd == 0.7 03:11:42 INFO - mozinfo == 0.9 03:11:42 INFO - mozleak == 0.1 03:11:42 INFO - mozlog == 3.1 03:11:42 INFO - moznetwork == 0.27 03:11:42 INFO - mozprocess == 0.22 03:11:42 INFO - mozprofile == 0.28 03:11:42 INFO - mozrunner == 6.11 03:11:42 INFO - mozscreenshot == 0.1 03:11:42 INFO - mozsystemmonitor == 0.0 03:11:42 INFO - moztest == 0.7 03:11:42 INFO - mozversion == 1.4 03:11:42 INFO - psutil == 3.1.1 03:11:42 INFO - requests == 1.2.3 03:11:42 INFO - wsgiref == 0.1.2 03:11:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:42 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 0x7f5dee816f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1783410>, '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 0x1784310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17847a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', '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:11:42 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:11:42 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:11:42 INFO - Using env: {'DISPLAY': ':0', 03:11:42 INFO - 'HOME': '/home/cltbld', 03:11:42 INFO - 'LANG': 'en_US.UTF-8', 03:11:42 INFO - 'LANGUAGE': 'en_US:en', 03:11:42 INFO - 'LOGNAME': 'cltbld', 03:11:42 INFO - 'MAIL': '/var/mail/cltbld', 03:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:42 INFO - 'MOZ_NO_REMOTE': '1', 03:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:42 INFO - 'NO_EM_RESTART': '1', 03:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:42 INFO - 'PWD': '/builds/slave/test', 03:11:42 INFO - 'SHELL': '/bin/bash', 03:11:42 INFO - 'SHLVL': '1', 03:11:42 INFO - 'TERM': 'linux', 03:11:42 INFO - 'TMOUT': '86400', 03:11:42 INFO - 'USER': 'cltbld', 03:11:42 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', 03:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:42 INFO - '_': '/tools/buildbot/bin/python'} 03:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:42 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:11:42 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:11:42 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:11:42 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:11:42 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:11:42 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:11:42 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:11:42 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:11:42 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:11:42 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:11:42 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:11:42 INFO - Cleaning up... 03:11:42 INFO - Return code: 0 03:11:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:42 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 0x7f5dee816f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1783410>, '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 0x1784310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17847a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', '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:11:42 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:11:42 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:11:42 INFO - Using env: {'DISPLAY': ':0', 03:11:42 INFO - 'HOME': '/home/cltbld', 03:11:42 INFO - 'LANG': 'en_US.UTF-8', 03:11:42 INFO - 'LANGUAGE': 'en_US:en', 03:11:42 INFO - 'LOGNAME': 'cltbld', 03:11:42 INFO - 'MAIL': '/var/mail/cltbld', 03:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:42 INFO - 'MOZ_NO_REMOTE': '1', 03:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:42 INFO - 'NO_EM_RESTART': '1', 03:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:42 INFO - 'PWD': '/builds/slave/test', 03:11:42 INFO - 'SHELL': '/bin/bash', 03:11:42 INFO - 'SHLVL': '1', 03:11:42 INFO - 'TERM': 'linux', 03:11:42 INFO - 'TMOUT': '86400', 03:11:42 INFO - 'USER': 'cltbld', 03:11:42 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', 03:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:42 INFO - '_': '/tools/buildbot/bin/python'} 03:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:42 INFO - Downloading/unpacking jsonschema 03:11:42 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:11:42 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:11:42 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:11:42 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:11:42 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:11:42 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:11:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:11:44 INFO - Downloading/unpacking functools32 (from jsonschema) 03:11:44 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:11:44 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:11:44 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:11:44 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:11:44 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:11:44 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:11:44 INFO - Downloading functools32-3.2.3-2.tar.gz 03:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:11:44 INFO - warning: no files found matching '*.txt' 03:11:44 INFO - no previously-included directories found matching 'build' 03:11:44 INFO - no previously-included directories found matching 'dist' 03:11:44 INFO - no previously-included directories found matching '.git*' 03:11:44 INFO - Installing collected packages: jsonschema, functools32 03:11:44 INFO - Running setup.py install for functools32 03:11:44 INFO - warning: no files found matching '*.txt' 03:11:44 INFO - no previously-included directories found matching 'build' 03:11:44 INFO - no previously-included directories found matching 'dist' 03:11:44 INFO - no previously-included directories found matching '.git*' 03:11:44 INFO - Successfully installed jsonschema functools32 03:11:44 INFO - Cleaning up... 03:11:45 INFO - Return code: 0 03:11:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:45 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 0x7f5dee816f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1783410>, '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 0x1784310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17847a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', '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:11:45 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:11:45 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:11:45 INFO - Using env: {'DISPLAY': ':0', 03:11:45 INFO - 'HOME': '/home/cltbld', 03:11:45 INFO - 'LANG': 'en_US.UTF-8', 03:11:45 INFO - 'LANGUAGE': 'en_US:en', 03:11:45 INFO - 'LOGNAME': 'cltbld', 03:11:45 INFO - 'MAIL': '/var/mail/cltbld', 03:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:45 INFO - 'MOZ_NO_REMOTE': '1', 03:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:45 INFO - 'NO_EM_RESTART': '1', 03:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:45 INFO - 'PWD': '/builds/slave/test', 03:11:45 INFO - 'SHELL': '/bin/bash', 03:11:45 INFO - 'SHLVL': '1', 03:11:45 INFO - 'TERM': 'linux', 03:11:45 INFO - 'TMOUT': '86400', 03:11:45 INFO - 'USER': 'cltbld', 03:11:45 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', 03:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:45 INFO - '_': '/tools/buildbot/bin/python'} 03:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:45 INFO - Downloading/unpacking flake8 03:11:45 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:11:45 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:11:45 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:11:45 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:11:45 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:11:45 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:11:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:11:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:11:47 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:11:47 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:11:47 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:11:47 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:11:47 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:11:47 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:11:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:11:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:11:47 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:11:47 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:11:47 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:11:47 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:11:47 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:11:47 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:11:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:11:47 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:11:47 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:11:47 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:11:47 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:11:47 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:11:47 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:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:11:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:11:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:11:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:11:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:11:47 INFO - no previously-included directories found matching 'docs/_build' 03:11:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:11:47 INFO - Running setup.py install for pep8 03:11:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:11:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:11:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:11:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:11:47 INFO - no previously-included directories found matching 'docs/_build' 03:11:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:11:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:11:48 INFO - Cleaning up... 03:11:48 INFO - Return code: 0 03:11:48 INFO - Running post-action listener: _resource_record_post_action 03:11:48 INFO - Running post-action listener: _start_resource_monitoring 03:11:48 INFO - Starting resource monitoring. 03:11:48 INFO - ##### 03:11:48 INFO - ##### Running install step. 03:11:48 INFO - ##### 03:11:48 INFO - Running pre-action listener: _resource_record_pre_action 03:11:48 INFO - Running main action method: install 03:11:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:11:48 INFO - Reading from file tmpfile_stdout 03:11:48 INFO - Detecting whether we're running mozinstall >=1.0... 03:11:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:11:48 INFO - Reading from file tmpfile_stdout 03:11:48 INFO - Output received: 03:11:48 INFO - Usage: mozinstall [options] installer 03:11:48 INFO - Options: 03:11:48 INFO - -h, --help show this help message and exit 03:11:48 INFO - -d DEST, --destination=DEST 03:11:48 INFO - Directory to install application into. [default: 03:11:48 INFO - "/builds/slave/test"] 03:11:48 INFO - --app=APP Application being installed. [default: firefox] 03:11:48 INFO - mkdir: /builds/slave/test/build/application 03:11:48 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:11:48 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:12:04 INFO - Reading from file tmpfile_stdout 03:12:04 INFO - Output received: 03:12:04 INFO - /builds/slave/test/build/application/firefox/firefox 03:12:04 INFO - Running post-action listener: _resource_record_post_action 03:12:04 INFO - ##### 03:12:04 INFO - ##### Running run-tests step. 03:12:04 INFO - ##### 03:12:04 INFO - Running pre-action listener: _resource_record_pre_action 03:12:04 INFO - Running main action method: run_tests 03:12:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:12:04 INFO - Python 2.7.3 03:12:04 INFO - Return code: 0 03:12:04 INFO - grabbing minidump binary from tooltool 03:12: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:12:04 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 0x1783410>, '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 0x1784310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17847a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:12:04 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:12:04 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:12:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:12:04 INFO - Return code: 0 03:12:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:12:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:12:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:12:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:12:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:12:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:12:05 INFO - Return code: 0 03:12:05 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/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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:12:05 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/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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:12:05 INFO - Using env: {'DISPLAY': ':0', 03:12:05 INFO - 'HOME': '/home/cltbld', 03:12:05 INFO - 'LANG': 'en_US.UTF-8', 03:12:05 INFO - 'LANGUAGE': 'en_US:en', 03:12:05 INFO - 'LOGNAME': 'cltbld', 03:12:05 INFO - 'MAIL': '/var/mail/cltbld', 03:12:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:12:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:05 INFO - 'MOZ_NO_REMOTE': '1', 03:12:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:05 INFO - 'NO_EM_RESTART': '1', 03:12:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:05 INFO - 'PWD': '/builds/slave/test', 03:12:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:12:05 INFO - 'SHELL': '/bin/bash', 03:12:05 INFO - 'SHLVL': '1', 03:12:05 INFO - 'TERM': 'linux', 03:12:05 INFO - 'TMOUT': '86400', 03:12:05 INFO - 'USER': 'cltbld', 03:12:05 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808', 03:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:05 INFO - '_': '/tools/buildbot/bin/python'} 03:12:05 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/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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:12:05 INFO - mozversion application_buildid: 20160525152143 03:12:05 INFO - mozversion application_changeset: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 03:12:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:12:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:12:05 INFO - mozversion application_name: Firefox 03:12:05 INFO - mozversion application_remotingname: firefox-dev 03:12:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:12:05 INFO - mozversion application_vendor: Mozilla 03:12:05 INFO - mozversion application_version: 48.0a2 03:12:05 INFO - mozversion platform_buildid: 20160525152143 03:12:05 INFO - mozversion platform_changeset: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 03:12:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:12:05 INFO - mozversion platform_version: 48.0a2 03:12:05 INFO - using testdate: 1464430325 03:12:05 INFO - actual date: 1464430325 03:12:05 INFO - starting webserver on 'localhost:51679' 03:12:05 INFO - SUITE-START | Running 2 tests 03:12:05 INFO - TEST-START | dromaeo_css 03:12:05 INFO - operating with platform_type : linux_ 03:12:05 INFO - Initialising browser for dromaeo_css test... 03:12:05 INFO - TEST-INFO | started process 17168 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVluHk6/profile http://localhost:51679/getInfo.html) 03:12:09 INFO - PROCESS | 17168 | __metrics Screen width/height:1600/1200 03:12:09 INFO - PROCESS | 17168 | colorDepth:24 03:12:09 INFO - PROCESS | 17168 | Browser inner width/height: 1024/697 03:12:09 INFO - PROCESS | 17168 | __metrics 03:12:10 ERROR - PROCESS | 17168 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:12:11 INFO - TEST-INFO | 17168: exit 0 03:12:11 INFO - Browser initialized. 03:12:11 INFO - Running cycle 1/1 for dromaeo_css test... 03:12:11 INFO - TEST-INFO | started process 17261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVluHk6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:22 INFO - PROCESS | 17261 | RSS: Main: 141381632 03:12:22 INFO - PROCESS | 17261 | 03:13:13 INFO - PROCESS | 17261 | 1464430393981 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:15:21 INFO - PROCESS | 17261 | Cycle 1(1): loaded http://localhost:51679/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51679/tests/dromaeo/cssquery-ext.html) 03:15:22 INFO - PROCESS | 17261 | RSS: Main: 246177792 03:15:22 INFO - PROCESS | 17261 | 03:18:24 INFO - PROCESS | 17261 | Cycle 1(1): loaded http://localhost:51679/tests/dromaeo/cssquery-ext.html (next: http://localhost:51679/tests/dromaeo/cssquery-jquery.html) 03:18:25 INFO - PROCESS | 17261 | RSS: Main: 223723520 03:18:25 INFO - PROCESS | 17261 | 03:21:27 INFO - PROCESS | 17261 | Cycle 1(1): loaded http://localhost:51679/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51679/tests/dromaeo/cssquery-mootools.html) 03:21:27 INFO - PROCESS | 17261 | RSS: Main: 221769728 03:21:27 INFO - PROCESS | 17261 | 03:24:29 INFO - PROCESS | 17261 | Cycle 1(1): loaded http://localhost:51679/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51679/tests/dromaeo/cssquery-prototype.html) 03:24:30 INFO - PROCESS | 17261 | RSS: Main: 213823488 03:24:30 INFO - PROCESS | 17261 | 03:27:32 INFO - PROCESS | 17261 | Cycle 1(1): loaded http://localhost:51679/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51679/tests/dromaeo/cssquery-yui.html) 03:27:33 INFO - PROCESS | 17261 | RSS: Main: 187125760 03:27:33 INFO - PROCESS | 17261 | 03:30:35 INFO - PROCESS | 17261 | Cycle 1(1): loaded http://localhost:51679/tests/dromaeo/cssquery-yui.html (next: http://localhost:51679/tests/dromaeo/cssquery-dojo.html) 03:30:35 INFO - PROCESS | 17261 | RSS: Main: 257998848 03:30:35 INFO - PROCESS | 17261 | 03:30:35 INFO - PROCESS | 17261 | __start_tp_report 03:30:35 INFO - PROCESS | 17261 | _x_x_mozilla_page_load 03:30:35 INFO - PROCESS | 17261 | _x_x_mozilla_page_load_details 03:30:35 INFO - PROCESS | 17261 | |i|pagename|runs| 03:30:35 INFO - PROCESS | 17261 | |0;dojo.html;3313.1220226639944;3354.379439803635;3369.1913940654235;3378.7465940054503;3407.1311815487047;5470.726463676815;5485.61600687952;5494.532964697995;5497.532709719669;5508.394076651565;5477.260569823073;5516.806911758089;5532.336119665646;5539;5565.554755619551;4948.529889660485;4961.776720047606;5012.04771093491;5060.190369540875;5103.795848166069;4982.651214414992;5047.369078865142;5052.9747351263195;5056.342675452204;5058.038972595214;5068.46781087986;5139.486051394868;5158.742062896859;5160.045391602565;5190.377154741436;5162.638615296931;5168.9224661630105;5185.844424667228;5189.974050129726;5213.061648903196;4902.779374928136;4998.900021999576;5007.69953802773;5075.4163271223915;5083.567896728782;5359.088954877641;5409.080456322435;5413.756380962826;5423.186522021689;5440.6735595864375;5927.170196172539;5956.940430595682;5961.612495187842;5961.672108034057;5966;5979.850503737398;5987.371326010793;6075.362086980847;6088.025915853486;6097.02447608385;5624.240727501776;5654.519365853907;5671.886562268732;5673.574481913873;5705.5435565154685;6029.758809647565;6147.047207682816;6182.072689096672;6186.81439556805;6188.0717892315615;5763.625364351387;5818.941810581925;5841.269841269841;5842.269716285465;5853.7365818538265;5924.31870334917;5931.703414829241;5939.049752039653;5942.970285148546;5947.018741907536;5821.417858214145;5922.378150294243;5936.643801371932;5942.554308426886;5951.553633477506;5936.109583562414;5970.6417614942375;5975.073863551156;5980.641161530322;6020.69896505173;4541.069080838421;4542.909141817145;4555.886102847456;4559.840405585855;4581.9541804582195;4007.3988901664984;4010.979945100256;4063.9390409143884;4065.7560546367313;4117.1765646870745;5649.491545760901;5654.6324488908085;5665.631733937281;5672.432756724294;5678.914816277759;5943.821685349447;5946.881062378815;5947.791827286024;5967.104934259809;5967.224260846149;5503.422140675251;5551.056320425457;5587.161925711176;5641.830745077655;5664.631798933056;5115.2071428928575;5117.257997590328;5128.230765385222;5152.484751524892;5172.069027574998;6204.317525072239;6238.064290356483;6243.625382477066;6244.781432649836;6254;5769.509591684754;5991.490723288569;6023.909641355383;6098.664573448503;6124.54065945047;6217.347178546368;6219.036049412348;6228.408301211378;6236.220472440945;6259;5888.558358123244;5889.764409423575;5898.262717160355;5907.261592300963;5921.6743079131065;5804.6807425592;5874.236349274567;5989.401059893976;6014.007688731311;6024.578279520391;5908.615939963888;5921.230240068763;5938.287405511366;5938.762449501972;5948.929192745348;5863.2670916135485;5883.470487656132;5905.704714764331;5919.526437884872;5925.555583331181;5656.236408084856;5731.684757338387;5769.567282453917;5806.912896306643;5821.27234095738;5834.504067154339;5863.560232982629;5877.529797616095;5878.2064421302575;5883.0881213410275;5587.385387607441;5749.338826035059;5753.482186603226;5764.942350576441;5784.074548072288 03:30:35 INFO - PROCESS | 17261 | |1;ext.html;607.7477846693622;661.708848106833;663.5189487621471;663.6681659170416;673.5689158938284;29280.560791588145;29872.551911721286;29880.551791723115;29921.40157196855;29946;34990.125246868774;35108.824455877686;35269.82365088177;35312.47031294526;35493.112672183146;8540.274076703472;8656.091110433408;8705.825883482326;8708.129187081273;8717.476951382905;8100.2304781045705;8672.046074931752;8850.5574721264;10276.691699249035;10487.108595769369;10538.47307634619;10630.46847657618;10637.414942178177;10642.308249963728;10642.680719578426;10221.437820919846;10280.177585793119;10280.48597570126;10286.537105830255;10298.691039268833;10013.198944084528;10039.34744241622;10086.596536138546;10088.94955525225;10101.090901818872;34392.656073439444;34796.956091317305;36967;36973.63026369729;37032.814835925914;3392.4402473592077;3404.710599599037;3484.9303013939834;3519.7360197985254;3762.6801721853676;30177.396452070836;30281;30378.84810575955;30527.236819079477;31959.840200798848;4473.597376236155;4498.8425405110665;4513.977430112828;4570.063137056929;4594.150082234763;277393;282590;283813.58093209605;283870;284240;34255.828720856734;34742.30515389678;49547.25679114816;50310.74844625754;50397;33343.83328083344;33406.49890251648;33485.33029339399;33587.66412335894;33590.16024599356;13320.866791331962;13341.66645833862;13373;13482.93258533701;13489.662758431117;9993;10775.892241077645;10821.783564328827;10821.783564328827;10921.945390273157;8246.257836794717;8321.334293256525;8354.830323754679;8373.120822313691;8393.790155246046;3235.7573182010974;3264.4124057669374;3278.9672103278663;3286.901392958215;3341.61571419285;983.5279066048337;1027.5427434791445;1032.0969151992008;1051.395447617623;1081.7187531241777;26255.868720656657;26293;26807.597886031726;27070.729292707216;27401.725982739918;1085.4518468173521;1090.4384242115316;1135.006868989634;1159.1827761428174;1185.466540056978;15105.169215693022;15402.537923862303;15481.5355539334;15507.302171402314;15763.842361576466;461081;518779;527668;527903;528785;47061.76469117632;47443.76278118656;47916.28125578119;48251.75874120677;48259.276110858365;1339.77223871942;1408.9929550352183;1429.335359058043;1441.8558144185708;1446.5298777897226;27057.458850823266;29281.707182927898;29742.55386169166;30276.394472110875;30903.072907812802;42745.1450970985;43097.13805723931;43174.568254317055;43467.347989780814;43578;341415;343699;343910;344889;344969;25395.98416063337;27494;27882.721172788824;28147.296317592223;28197;38458.23083538258;38794;38990.80504597459;39204.21591568096;39363.409548857366;33976.490352644236;34749.82625086858;35253;35480;36281.27437451289;34332.656673432946;35007;35482;35569.1107722309;35619.64380356267;34836.651633484355;35100.82449587736;35527.11182220362;35596.82201588975;36617;30818.691813081583;32049.359012819146;32228.677713223504;32328.676713232566;32532.51201231936;25496.872515637304;26002.479950400506;26131.869340653175;26767;27722 03:30:35 INFO - PROCESS | 17261 | |2;jquery.html;405.44049212087316;407.74719673802247;410.64889519460843;416.6063070398475;421.66753060329347;16505.504834854975;16748.330066797327;17409.564760880985;17431.738523922137;18178.363757268497;12965.092443528956;13617.387217575208;14960.102393856376;15489.922550387233;15788.921055394736;5356.1697936819755;5555.611107222476;5584.553235741131;5590.273264475612;5599.7480113394995;5301.920471192935;5429.294191755066;5506.889862202754;5530.917036244459;5537.916931246034;5488.039593071217;5489.231507588941;5504.834854954358;5515.61390702651;5518.061929471979;5455.18172274158;5466.098093814516;5467.261919640838;5702.600817942745;6085.4827339676185;5468.644538105011;5490.890182196334;5510.090835012218;5511.58663100269;5517.200005999108;18890.52773680655;20422.387328380173;20590.691139632916;20716.89641551798;20835.16659333625;2400.303911865557;2457;2480.0203919451715;2930.985345073282;3081.599392079038;9980.101790838788;10263.538140783683;10308.484575771256;10431.79136417275;10569.841452378221;1950.8634395592314;1971.3691618682028;2099.8950052497466;2132.115172203534;2165.902534385956;75004;78173;81033.59483202605;81798.18201818025;84277.57861210716;10105.29262951601;10417.895821041693;10607.94696026515;10816.729581760519;10917.344959302467;13381.130226535244;13582.185068895898;13601.115927464882;13613.591592252249;13614.795778063337;7153.89269160963;7425.554466732014;7472.5516469010945;7505.211952744883;7540.811479712941;7142.107236595426;7220.963895180491;7242.167150777623;7255.23819998903;7421.2949769771785;4299.333603291495;4506.039872655406;4567.314902764612;4793.089313030583;5070.746462676925;1897.155765684285;1908.9236430542624;1918.424472658197;1926.258390519632;2027.3715148303777;889.888763904512;901.7925877048316;920.40173886974;941.4962994797751;974.4640447753707;16453.58866028359;16650.417235396704;16673.416430424877;16863;17113.743293850603;948.8376738495288;957.2916042128913;966.2897770139083;973.6689525561343;1027.0345874877592;7039.859202816017;9406.717798466058;9539.379940303857;9590.952045239728;9664.178544823768;499610;504752;515330;516017;518733;54904.72547637236;78463.21536784673;87713;88360;92282.0771792287;939.0797018921495;963.272729089533;964.3056998960737;967.8209531236744;978.4325091446801;14982.325795339453;14987.850121498646;15257.660167131184;15271.61820954485;15327.157006364758;39431.80284098561;39713.60286397099;39930.80034599808;40613.59386406098;40983;57474.7126264366;58963.41036589751;59026;59069.704651476466;59089;8888.244499217639;8897.555122243732;8979.119832918954;8992.415492992934;9073.183413492818;9405.905940940776;9578.521073946136;9595.760105997406;9854.310198286337;9920.900790991998;8664.393492455467;8784.472931624123;8796.208341249318;8835.285736900418;8936.821263574822;8790.956045219733;8972.41679290844;9045;9208.355415120877;9272.258219342571;7507.512011719221;7660.004199454035;9092.181703646704;9290.535473226448;9402.059794020543;12269.93865030669;12684.492620295454;12694.555690550786;12703.745925081632;12928.741425171633;12296.692582685504;12361.814572781235;12400.937995309965;12563.497460101493;12578.119531632698 03:30:35 INFO - PROCESS | 17261 | |3;mootools.html;1240.8262843201949;1420.9715805683884;1462.4881291547956;1555.9377624895005;1739.956501087472;7371.741989030378;8175.059868115169;8288.91711082889;8304.792380190498;8327.958360208191;8169.59152042397;8315.75052748417;8318.126596707334;8320.875186872201;8339.45793523422;2125.0968338456173;2176.1730542393866;2380.9166679166233;2411.565918134735;2429.854208747472;2374.323317854412;2411.5418070566625;2412.7587241275905;2413.456972181254;2414.95170096598;2360.3391050505884;2405.4106743847783;2406.8916898739512;2408.7350391456926;2409.4819613783034;2083.2083808152956;2326.3718795925174;2358.9738463768317;2374.513224788914;2405.6391541268777;2319.060780383947;2338.275134708246;2359.2686267257204;2360.2565191964477;2360.7521210273017;8021.117677055519;8134.471259368122;8136.511809291462;8138.674453021872;8140.9592952035455;5185.870353241162;5257.76340064698;5295.7881684732565;5300.734963251861;5303.284056652341;3469.2541103662834;3499.2826470573473;3526.5239192708914;3556.8399422026073;3560.893173204808;1088.970808010357;1164.0687450040018;1174.1604752601932;1184.2006645514243;1197.4012993503247;12100.878991210064;12251.877481225163;12256.754864902652;12331.568395106218;12370.62888113349;4733.05359734867;4789.401324834395;4822.132016237111;4837.685550439211;4891.5353041461;10018.599256029824;10063.899361006443;10072.294939354322;10083;10085.69742907714;5336.1462166054025;5399.568034557226;5405.054115529767;5407.351117865881;5408.269883565668;4305.870823875289;4742.454617718938;4820.927686084711;4825.565699087099;4830.951690483121;4077.55146933837;4082.755034697928;4120.75275483472;4190.371444283321;4280.59334363235;1323.9801402978962;1337.8862796662197;1339.8392192936715;1342.5770882172085;1360.6054244269249;788.8895554622358;833.3125171733344;877.140402405646;896.6906417286026;908.1962463220098;5611.268391881635;5672.7730890763905;5731.226284451629;5733;5854.941450585525;1007.6271779441654;1028.1620479309488;1047.2302857399804;1048.895110488945;1055.567217440861;3771.41543060826;3774.452704357853;3784.924301513954;3787.9431808522895;3837.520309961255;10124.949375253076;10165.135963443043;10405.167586593054;10534.894651053544;10545.31455455393;10337.638182663572;10396.116330112025;10434;10441.582336706599;10443.68668939933;7846.607669616496;8071.878921816177;8072.233137851895;8257.504549727035;8262.049864265686;5544.916826247529;5574.275344205227;5602.579806514446;5615.241942337732;5623.240862483676;9481.52592370365;9711.465869376969;9719.416834989923;9778.462184579916;9796.951015244878;9140.131687489678;9531.809363812547;9547.140757331874;9868.161206297546;9889.307748457826;6917.792466226021;7311.159216690149;7475.551466912003;7509.924900751141;7629.7329593463965;7945.682172713026;7960.920390796018;7980;8014.679412823421;8029.076656184614;7264.455165862476;7292.416606671348;7340.669669864762;7424;7428.591427471325;6884.311568843276;7354.374878135419;7389.593572353572;7404.777856664308;7512.098548174035;6954.165500140016;7019.894701579378;7105.715771369088;7138;7152.964235178791;4879.804807807648;4882.389701287339;4966.801327946841;4975.925361119658;5022.874428139326;4994.1260279450225;5053.545180933734;5074.467180946095;5134.255532947776;5178.016176926372 03:30:35 INFO - PROCESS | 17261 | |4;prototype.html;362.0803159973667;366.1468777747848;367.08229426433917;373;374.67590534187934;6006.369331220225;6093.512518998475;6147.415995480428;6181.505479561635;6202.9999999999945;6156.476699480539;6214.751409943597;6214.751409943608;6221.471174950123;6226.43962043416;4577.153226653079;4665.930011049837;4709.411323584552;4766.5471780180915;4789.257665061921;4783.641226907996;4788.616910647157;4793.32893394925;4797.0645724083815;4798.04039192163;4759.524047595248;4760.642951778613;4766.833160839371;4775.80896764129;4778.856634300959;4764.642651801111;4766.046790641885;4770.356001939763;4773.880652983703;4775.761211939423;4218.873433796991;4219.493660760698;4225.176090662322;4238.406623072772;4238.554951730086;5744.22452968848;5919.260092488439;5958.672273024982;5958.851028724273;5968.641881487125;5416.83749487516;5427.83716488506;5443.346798384219;5444.754986025639;5471.616986810925;6502.967485162591;6506.1216735740545;6510.18622672166;6515.609063456208;6527.93472065278;4426.136903303857;4507.639388848885;4529.796159172845;4588.908221835544;4591.977040114812;6688.899666505006;6748.460123190133;6763.053172555895;6774.220964589086;6779.186497620268;4635.119327327797;4636.072785442858;4639.628829693616;4642;4643.930341044887;4694.037722266927;4696.272077827942;4696.976515117402;4699.553542413465;4703.223968045303;5145.382554093533;5276.683398995996;5374.328208973879;5425.755840987165;5428.5114339708825;6454.774082907075;6514.218293804774;6516.902246466307;6532.575382600211;6548.0177973303435;1641.4501142117524;1663.9584010399594;1666.4833901490576;1667.1080971680092;1668.0992264177207;1075.1936047964027;1092.0990183098975;1093.03812644872;1110.4947249001684;1113.204059097749;6339.492840572743;6345.428911397997;6360.6501642409185;6364.586301890362;6368.29948705642;6745.56153850008;6746.0892779475125;6748.595084294958;6749.561278516979;6784.219814721271;6288.402601752826;6349.206349206349;6354.936450635434;6358.3641635836975;6361.936380636227;3599.3341231872187;3629.927401451956;3631.3463576555946;3634.83643236055;3637.4907512948207;6837.931620683829;6864.347886950732;6905.516613836983;6985.860282794417;6990.335918087773;6851.3491218334175;6859.451243900476;6863.519553631198;6866.759663411856;6874.415674667609;6951.860962780817;6953.304669533006;6961.686724097326;6962.547434416747;6980.057692211486;6659.600423974577;6706.094677218513;6711.63086030273;6712.429443497357;6717.093192418961;6473.158489396536;6620.172478440195;6623.635700036351;6624.834379140368;6628.304028077176;6800.353966373186;6830.282820303995;6846.110005699426;6847.6576171190245;6849.075374824534;4678.766061696833;4679.859604211879;4687.460941991714;4689.062187562433;4694.037722266995;6456.160699109086;6540.411362977355;6670.733170673118;6674.798536263519;6678.799636010927;6443;6565.606063636006;6574.934250657432;6584.374484423972;6665.366790154928;6521.902171467526;6531.11829902976;6533.869322613426;6538.411542961157;6554.705038273194;6434.67826608677;6435.549511534147;6440.549161558646;6443.548951573533;6443.677816109082;6460.224773027267;6589.703463344257;6599.439047681001;6602.207735071822;6604.636744979072;6419.325970773001;6436.066770318372;6442.903356449563;6443;6446.645434501147 03:30:35 INFO - PROCESS | 17261 | |5;yui.html;693.4937495628192;741.9962900185502;746.7908985484066;752.3980815347722;766.7354762606902;14275;14419.279036048209;14434;14471.34878930448;14471.855281447195;12880.227186368824;12973.675658108528;12978.870211297884;12984.415701293441;13003;542.2950164785782;606.3905774696424;613.2181468627502;616.0758861707438;617.3271134463456;620.618319733363;625.2715586341906;626.1234272019187;628.2617923939375;630.8927482327992;635.4820821030868;637.3849235487753;638.7061951502315;638.881806865729;640.0974625777654;558.4359796605437;624.7001439309134;629.9527535434838;643.0803950350996;651.7849109793757;478.63862783598506;479.302614695617;481.67005601163316;481.6796830107974;482.3440121434846;13545.39045742944;13592;13595.116317439335;13601.931990340085;13613.591592252149;13816.240106794123;14182.929085354508;14195;14223.28883555818;14250.429982800675;11923.821142682868;12316.876831231662;12470.309377525844;12650.620481385573;13001.544945926848;3907.2966865964113;3967.4842270504937;4006.3790112532606;4007.6593489553425;4021;58860.41139588592;59249;59794.70102649502;60225.69887150536;60358.69820650913;10370.844437333446;10394.16846652266;10417.42704151279;10483.47582620866;10694.518746656418;17901.7314740279;17922.372716954844;17923.910380448015;17963;17971.101444927703;8385.538795366314;8413.116622754522;8481.660733570712;8522.829543409222;8574.356923230782;4867.148249056401;4898.167311557044;4942.382202224722;4998.925016124761;5013.573846223112;3286.3920174767745;3299.983500082484;3320.6015278166774;3337.332533493311;3342.766006379579;579.6087640842414;583.9211706419663;593.6111846740392;600.3966014155745;608.4219991008559;598.8862116197909;657.8947368421029;690.6650274616807;718.2996578336185;749.6439191384048;9610.6664023197;9974.102330790118;9993.050660187271;9996.150327222122;10170.847437288447;663.4062514049898;704.5913370245348;718.90294810201;768.3584207187062;772.7874834420579;4329.295759309763;4365.345198220292;4432.49026361966;4525.932111018337;4595.448546174481;64360.678196608715;66106;66523.33476665268;67199.32800672029;67221;57223;57734.845303094546;58256;58387.416125839045;58756.41243587509;47680.28479572809;49094.75452622786;51967;53116.73441632767;53590.196147057824;9984.722828459107;10179.694609161737;10278.691639250834;10285.485725713535;10397.11624511925;38384.42423363596;38716.225675486894;38824.611753883226;38830.805845970586;39808.40287395634;45419.318710218715;46530.767346163055;49819.50180498149;51081.489185107675;52937.735311323195;11531.1351648625;11624.94187529057;11650.067994560584;11655.358955257543;12185.756284874431;14039.929800350932;14304.57086287413;14341.139531628136;14362.856371436152;14449.277536123362;12825.422855971317;13301.401436935168;13314.800277995644;13674.179549227078;13812.516561920285;12879.678008049874;12923.806142908052;12940.417681204557;12946.616641968316;12997.310627487384;13049;13123.409446575119;13147.408366623333;13312.866871331164;13340.132891362031;11279.7744045117;11405.20163588574;11466;11630.302181869114;11631.243969142317;11116.49975751077;11182.944085279521;11280.32318060919;11333.489992950172;11354.602588909678 03:30:35 INFO - PROCESS | 17261 | __end_tp_report 03:30:35 INFO - PROCESS | 17261 | __start_cc_report 03:30:35 INFO - PROCESS | 17261 | _x_x_mozilla_cycle_collect,804 03:30:35 INFO - PROCESS | 17261 | __end_cc_report 03:30:35 INFO - PROCESS | 17261 | __startTimestamp1464431435893__endTimestamp 03:30:35 INFO - PROCESS | 17261 | 03:30:35 INFO - PROCESS | 17261 | ------- Summary: start ------- 03:30:35 INFO - PROCESS | 17261 | Number of tests: 6 03:30:35 INFO - PROCESS | 17261 | 03:30:35 INFO - PROCESS | 17261 | [#0] dojo.html Cycles:165 Average:5548.65 Median:5769.51 stddev:623.51 (10.8%) stddev-sans-first:600.26 03:30:35 INFO - PROCESS | 17261 | Values: 3313.1 3354.4 3369.2 3378.7 3407.1 5470.7 5485.6 5494.5 5497.5 5508.4 5477.3 5516.8 5532.3 5539.0 5565.6 4948.5 4961.8 5012.0 5060.2 5103.8 4982.7 5047.4 5053.0 5056.3 5058.0 5068.5 5139.5 5158.7 5160.0 5190.4 5162.6 5168.9 5185.8 5190.0 5213.1 4902.8 4998.9 5007.7 5075.4 5083.6 5359.1 5409.1 5413.8 5423.2 5440.7 5927.2 5956.9 5961.6 5961.7 5966.0 5979.9 5987.4 6075.4 6088.0 6097.0 5624.2 5654.5 5671.9 5673.6 5705.5 6029.8 6147.0 6182.1 6186.8 6188.1 5763.6 5818.9 5841.3 5842.3 5853.7 5924.3 5931.7 5939.0 5943.0 5947.0 5821.4 5922.4 5936.6 5942.6 5951.6 5936.1 5970.6 5975.1 5980.6 6020.7 4541.1 4542.9 4555.9 4559.8 4582.0 4007.4 4011.0 4063.9 4065.8 4117.2 5649.5 5654.6 5665.6 5672.4 5678.9 5943.8 5946.9 5947.8 5967.1 5967.2 5503.4 5551.1 5587.2 5641.8 5664.6 5115.2 5117.3 5128.2 5152.5 5172.1 6204.3 6238.1 6243.6 6244.8 6254.0 5769.5 5991.5 6023.9 6098.7 6124.5 6217.3 6219.0 6228.4 6236.2 6259.0 5888.6 5889.8 5898.3 5907.3 5921.7 5804.7 5874.2 5989.4 6014.0 6024.6 5908.6 5921.2 5938.3 5938.8 5948.9 5863.3 5883.5 5905.7 5919.5 5925.6 5656.2 5731.7 5769.6 5806.9 5821.3 5834.5 5863.6 5877.5 5878.2 5883.1 5587.4 5749.3 5753.5 5764.9 5784.1 03:30:35 INFO - PROCESS | 17261 | 03:30:35 INFO - PROCESS | 17261 | [#1] ext.html Cycles:180 Average:51063.00 Median:18374.06 stddev:104350.35 (567.9%) stddev-sans-first:104574.32 03:30:35 INFO - PROCESS | 17261 | Values: 607.7 661.7 663.5 663.7 673.6 29280.6 29872.6 29880.6 29921.4 29946.0 34990.1 35108.8 35269.8 35312.5 35493.1 8540.3 8656.1 8705.8 8708.1 8717.5 8100.2 8672.0 8850.6 10276.7 10487.1 10538.5 10630.5 10637.4 10642.3 10642.7 10221.4 10280.2 10280.5 10286.5 10298.7 10013.2 10039.3 10086.6 10088.9 10101.1 34392.7 34797.0 36967.0 36973.6 37032.8 3392.4 3404.7 3484.9 3519.7 3762.7 30177.4 30281.0 30378.8 30527.2 31959.8 4473.6 4498.8 4514.0 4570.1 4594.2 277393.0 282590.0 283813.6 283870.0 284240.0 34255.8 34742.3 49547.3 50310.7 50397.0 33343.8 33406.5 33485.3 33587.7 33590.2 13320.9 13341.7 13373.0 13482.9 13489.7 9993.0 10775.9 10821.8 10821.8 10921.9 8246.3 8321.3 8354.8 8373.1 8393.8 3235.8 3264.4 3279.0 3286.9 3341.6 983.5 1027.5 1032.1 1051.4 1081.7 26255.9 26293.0 26807.6 27070.7 27401.7 1085.5 1090.4 1135.0 1159.2 1185.5 15105.2 15402.5 15481.5 15507.3 15763.8 461081.0 518779.0 527668.0 527903.0 528785.0 47061.8 47443.8 47916.3 48251.8 48259.3 1339.8 1409.0 1429.3 1441.9 1446.5 27057.5 29281.7 29742.6 30276.4 30903.1 42745.1 43097.1 43174.6 43467.3 43578.0 341415.0 343699.0 343910.0 344889.0 344969.0 25396.0 27494.0 27882.7 28147.3 28197.0 38458.2 38794.0 38990.8 39204.2 39363.4 33976.5 34749.8 35253.0 35480.0 36281.3 34332.7 35007.0 35482.0 35569.1 35619.6 34836.7 35100.8 35527.1 35596.8 36617.0 30818.7 32049.4 32228.7 32328.7 32532.5 25496.9 26002.5 26131.9 26767.0 27722.0 03:30:35 INFO - PROCESS | 17261 | 03:30:35 INFO - PROCESS | 17261 | [#2] jquery.html Cycles:180 Average:28465.46 Median:5467.95 stddev:84057.53 (1537.3%) stddev-sans-first:84266.93 03:30:35 INFO - PROCESS | 17261 | Values: 405.4 407.7 410.6 416.6 421.7 16505.5 16748.3 17409.6 17431.7 18178.4 12965.1 13617.4 14960.1 15489.9 15788.9 5356.2 5555.6 5584.6 5590.3 5599.7 5301.9 5429.3 5506.9 5530.9 5537.9 5488.0 5489.2 5504.8 5515.6 5518.1 5455.2 5466.1 5467.3 5702.6 6085.5 5468.6 5490.9 5510.1 5511.6 5517.2 18890.5 20422.4 20590.7 20716.9 20835.2 2400.3 2457.0 2480.0 2931.0 3081.6 9980.1 10263.5 10308.5 10431.8 10569.8 1950.9 1971.4 2099.9 2132.1 2165.9 75004.0 78173.0 81033.6 81798.2 84277.6 10105.3 10417.9 10607.9 10816.7 10917.3 13381.1 13582.2 13601.1 13613.6 13614.8 7153.9 7425.6 7472.6 7505.2 7540.8 7142.1 7221.0 7242.2 7255.2 7421.3 4299.3 4506.0 4567.3 4793.1 5070.7 1897.2 1908.9 1918.4 1926.3 2027.4 889.9 901.8 920.4 941.5 974.5 16453.6 16650.4 16673.4 16863.0 17113.7 948.8 957.3 966.3 973.7 1027.0 7039.9 9406.7 9539.4 9591.0 9664.2 499610.0 504752.0 515330.0 516017.0 518733.0 54904.7 78463.2 87713.0 88360.0 92282.1 939.1 963.3 964.3 967.8 978.4 14982.3 14987.9 15257.7 15271.6 15327.2 39431.8 39713.6 39930.8 40613.6 40983.0 57474.7 58963.4 59026.0 59069.7 59089.0 8888.2 8897.6 8979.1 8992.4 9073.2 9405.9 9578.5 9595.8 9854.3 9920.9 8664.4 8784.5 8796.2 8835.3 8936.8 8791.0 8972.4 9045.0 9208.4 9272.3 7507.5 7660.0 9092.2 9290.5 9402.1 12269.9 12684.5 12694.6 12703.7 12928.7 12296.7 12361.8 12400.9 12563.5 12578.1 03:30:35 INFO - PROCESS | 17261 | 03:30:35 INFO - PROCESS | 17261 | [#3] mootools.html Cycles:180 Average:5631.01 Median:4886.96 stddev:3122.74 (63.9%) stddev-sans-first:3114.07 03:30:35 INFO - PROCESS | 17261 | Values: 1240.8 1421.0 1462.5 1555.9 1740.0 7371.7 8175.1 8288.9 8304.8 8328.0 8169.6 8315.8 8318.1 8320.9 8339.5 2125.1 2176.2 2380.9 2411.6 2429.9 2374.3 2411.5 2412.8 2413.5 2415.0 2360.3 2405.4 2406.9 2408.7 2409.5 2083.2 2326.4 2359.0 2374.5 2405.6 2319.1 2338.3 2359.3 2360.3 2360.8 8021.1 8134.5 8136.5 8138.7 8141.0 5185.9 5257.8 5295.8 5300.7 5303.3 3469.3 3499.3 3526.5 3556.8 3560.9 1089.0 1164.1 1174.2 1184.2 1197.4 12100.9 12251.9 12256.8 12331.6 12370.6 4733.1 4789.4 4822.1 4837.7 4891.5 10018.6 10063.9 10072.3 10083.0 10085.7 5336.1 5399.6 5405.1 5407.4 5408.3 4305.9 4742.5 4820.9 4825.6 4831.0 4077.6 4082.8 4120.8 4190.4 4280.6 1324.0 1337.9 1339.8 1342.6 1360.6 788.9 833.3 877.1 896.7 908.2 5611.3 5672.8 5731.2 5733.0 5854.9 1007.6 1028.2 1047.2 1048.9 1055.6 3771.4 3774.5 3784.9 3787.9 3837.5 10124.9 10165.1 10405.2 10534.9 10545.3 10337.6 10396.1 10434.0 10441.6 10443.7 7846.6 8071.9 8072.2 8257.5 8262.0 5544.9 5574.3 5602.6 5615.2 5623.2 9481.5 9711.5 9719.4 9778.5 9797.0 9140.1 9531.8 9547.1 9868.2 9889.3 6917.8 7311.2 7475.6 7509.9 7629.7 7945.7 7960.9 7980.0 8014.7 8029.1 7264.5 7292.4 7340.7 7424.0 7428.6 6884.3 7354.4 7389.6 7404.8 7512.1 6954.2 7019.9 7105.7 7138.0 7153.0 4879.8 4882.4 4966.8 4975.9 5022.9 4994.1 5053.5 5074.5 5134.3 5178.0 03:30:35 INFO - PROCESS | 17261 | 03:30:35 INFO - PROCESS | 17261 | [#4] prototype.html Cycles:180 Average:5467.69 Median:6313.95 stddev:1631.50 (25.8%) stddev-sans-first:1590.44 03:30:35 INFO - PROCESS | 17261 | Values: 362.1 366.1 367.1 373.0 374.7 6006.4 6093.5 6147.4 6181.5 6203.0 6156.5 6214.8 6214.8 6221.5 6226.4 4577.2 4665.9 4709.4 4766.5 4789.3 4783.6 4788.6 4793.3 4797.1 4798.0 4759.5 4760.6 4766.8 4775.8 4778.9 4764.6 4766.0 4770.4 4773.9 4775.8 4218.9 4219.5 4225.2 4238.4 4238.6 5744.2 5919.3 5958.7 5958.9 5968.6 5416.8 5427.8 5443.3 5444.8 5471.6 6503.0 6506.1 6510.2 6515.6 6527.9 4426.1 4507.6 4529.8 4588.9 4592.0 6688.9 6748.5 6763.1 6774.2 6779.2 4635.1 4636.1 4639.6 4642.0 4643.9 4694.0 4696.3 4697.0 4699.6 4703.2 5145.4 5276.7 5374.3 5425.8 5428.5 6454.8 6514.2 6516.9 6532.6 6548.0 1641.5 1664.0 1666.5 1667.1 1668.1 1075.2 1092.1 1093.0 1110.5 1113.2 6339.5 6345.4 6360.7 6364.6 6368.3 6745.6 6746.1 6748.6 6749.6 6784.2 6288.4 6349.2 6354.9 6358.4 6361.9 3599.3 3629.9 3631.3 3634.8 3637.5 6837.9 6864.3 6905.5 6985.9 6990.3 6851.3 6859.5 6863.5 6866.8 6874.4 6951.9 6953.3 6961.7 6962.5 6980.1 6659.6 6706.1 6711.6 6712.4 6717.1 6473.2 6620.2 6623.6 6624.8 6628.3 6800.4 6830.3 6846.1 6847.7 6849.1 4678.8 4679.9 4687.5 4689.1 4694.0 6456.2 6540.4 6670.7 6674.8 6678.8 6443.0 6565.6 6574.9 6584.4 6665.4 6521.9 6531.1 6533.9 6538.4 6554.7 6434.7 6435.5 6440.5 6443.5 6443.7 6460.2 6589.7 6599.4 6602.2 6604.6 6419.3 6436.1 6442.9 6443.0 6446.6 03:30:35 INFO - PROCESS | 17261 | 03:30:35 INFO - PROCESS | 17261 | [#5] yui.html Cycles:180 Average:15514.66 Median:4347.32 stddev:18338.17 (421.8%) stddev-sans-first:18355.83 03:30:35 INFO - PROCESS | 17261 | Values: 693.5 742.0 746.8 752.4 766.7 14275.0 14419.3 14434.0 14471.3 14471.9 12880.2 12973.7 12978.9 12984.4 13003.0 542.3 606.4 613.2 616.1 617.3 620.6 625.3 626.1 628.3 630.9 635.5 637.4 638.7 638.9 640.1 558.4 624.7 630.0 643.1 651.8 478.6 479.3 481.7 481.7 482.3 13545.4 13592.0 13595.1 13601.9 13613.6 13816.2 14182.9 14195.0 14223.3 14250.4 11923.8 12316.9 12470.3 12650.6 13001.5 3907.3 3967.5 4006.4 4007.7 4021.0 58860.4 59249.0 59794.7 60225.7 60358.7 10370.8 10394.2 10417.4 10483.5 10694.5 17901.7 17922.4 17923.9 17963.0 17971.1 8385.5 8413.1 8481.7 8522.8 8574.4 4867.1 4898.2 4942.4 4998.9 5013.6 3286.4 3300.0 3320.6 3337.3 3342.8 579.6 583.9 593.6 600.4 608.4 598.9 657.9 690.7 718.3 749.6 9610.7 9974.1 9993.1 9996.2 10170.8 663.4 704.6 718.9 768.4 772.8 4329.3 4365.3 4432.5 4525.9 4595.4 64360.7 66106.0 66523.3 67199.3 67221.0 57223.0 57734.8 58256.0 58387.4 58756.4 47680.3 49094.8 51967.0 53116.7 53590.2 9984.7 10179.7 10278.7 10285.5 10397.1 38384.4 38716.2 38824.6 38830.8 39808.4 45419.3 46530.8 49819.5 51081.5 52937.7 11531.1 11624.9 11650.1 11655.4 12185.8 14039.9 14304.6 14341.1 14362.9 14449.3 12825.4 13301.4 13314.8 13674.2 13812.5 12879.7 12923.8 12940.4 12946.6 12997.3 13049.0 13123.4 13147.4 13312.9 13340.1 11279.8 11405.2 11466.0 11630.3 11631.2 11116.5 11182.9 11280.3 11333.5 11354.6 03:30:35 INFO - PROCESS | 17261 | -------- Summary: end -------- 03:30:35 INFO - PROCESS | 17261 | 03:30:36 INFO - TEST-INFO | 17261: exit 0 03:30:36 INFO - TEST-OK | dromaeo_css | took 1111407ms 03:30:36 INFO - TEST-START | kraken 03:30:36 INFO - operating with platform_type : linux_ 03:30:36 INFO - Initialising browser for kraken test... 03:30:36 INFO - TEST-INFO | started process 17454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppu6DYg/profile http://localhost:51679/getInfo.html) 03:30:40 INFO - PROCESS | 17454 | __metrics Screen width/height:1600/1200 03:30:40 INFO - PROCESS | 17454 | colorDepth:24 03:30:40 INFO - PROCESS | 17454 | Browser inner width/height: 1024/697 03:30:40 INFO - PROCESS | 17454 | __metrics 03:30:41 ERROR - PROCESS | 17454 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:30:42 INFO - TEST-INFO | 17454: exit 0 03:30:42 INFO - Browser initialized. 03:30:42 INFO - Running cycle 1/1 for kraken test... 03:30:42 INFO - TEST-INFO | started process 17542 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppu6DYg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:30:54 INFO - PROCESS | 17542 | RSS: Main: 141619200 03:30:54 INFO - PROCESS | 17542 | 03:30:56 INFO - PROCESS | 17542 | Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51679/tests/kraken/driver.html?testName=audio-beat-detection) 03:30:57 INFO - PROCESS | 17542 | RSS: Main: 196952064 03:30:57 INFO - PROCESS | 17542 | 03:31:00 INFO - PROCESS | 17542 | Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51679/tests/kraken/driver.html?testName=audio-dft) 03:31:00 INFO - PROCESS | 17542 | RSS: Main: 182878208 03:31:00 INFO - PROCESS | 17542 | 03:31:03 INFO - PROCESS | 17542 | Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51679/tests/kraken/driver.html?testName=audio-fft) 03:31:04 INFO - PROCESS | 17542 | RSS: Main: 273268736 03:31:04 INFO - PROCESS | 17542 | 03:31:06 INFO - PROCESS | 17542 | Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51679/tests/kraken/driver.html?testName=audio-oscillator) 03:31:06 INFO - PROCESS | 17542 | RSS: Main: 178892800 03:31:06 INFO - PROCESS | 17542 | 03:31:09 INFO - PROCESS | 17542 | Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51679/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:31:09 INFO - PROCESS | 17542 | RSS: Main: 177188864 03:31:09 INFO - PROCESS | 17542 | 03:31:12 INFO - PROCESS | 17542 | Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51679/tests/kraken/driver.html?testName=imaging-darkroom) 03:31:13 INFO - PROCESS | 17542 | RSS: Main: 212238336 03:31:13 INFO - PROCESS | 17542 | 03:31:16 INFO - PROCESS | 17542 | Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51679/tests/kraken/driver.html?testName=imaging-desaturate) 03:31:17 INFO - PROCESS | 17542 | RSS: Main: 212336640 03:31:17 INFO - PROCESS | 17542 | 03:31:19 INFO - PROCESS | 17542 | Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51679/tests/kraken/driver.html?testName=json-parse-financial) 03:31:20 INFO - PROCESS | 17542 | RSS: Main: 212156416 03:31:20 INFO - PROCESS | 17542 | 03:31:21 INFO - PROCESS | 17542 | Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51679/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:31:22 INFO - PROCESS | 17542 | RSS: Main: 189280256 03:31:22 INFO - PROCESS | 17542 | 03:31:24 INFO - PROCESS | 17542 | Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51679/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:31:24 INFO - PROCESS | 17542 | RSS: Main: 192196608 03:31:24 INFO - PROCESS | 17542 | 03:31:26 INFO - PROCESS | 17542 | Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51679/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:31:27 INFO - PROCESS | 17542 | RSS: Main: 207781888 03:31:27 INFO - PROCESS | 17542 | 03:31:29 INFO - PROCESS | 17542 | Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51679/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:31:30 INFO - PROCESS | 17542 | RSS: Main: 213196800 03:31:30 INFO - PROCESS | 17542 | 03:31:33 INFO - PROCESS | 17542 | Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51679/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:31:33 INFO - PROCESS | 17542 | RSS: Main: 208011264 03:31:33 INFO - PROCESS | 17542 | 03:31:35 INFO - PROCESS | 17542 | Cycle 1(1): loaded http://localhost:51679/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51679/tests/kraken/driver.html?testName=ai-astar) 03:31:35 INFO - PROCESS | 17542 | RSS: Main: 271437824 03:31:35 INFO - PROCESS | 17542 | 03:31:35 INFO - PROCESS | 17542 | __start_tp_report 03:31:35 INFO - PROCESS | 17542 | _x_x_mozilla_page_load 03:31:35 INFO - PROCESS | 17542 | _x_x_mozilla_page_load_details 03:31:35 INFO - PROCESS | 17542 | |i|pagename|runs| 03:31:35 INFO - PROCESS | 17542 | |0;ai-astar;112;110;110;110;111;110;106;111;110;109 03:31:35 INFO - PROCESS | 17542 | |1;audio-beat-detection;151;130;155;182;126;153;154;131;174;135 03:31:35 INFO - PROCESS | 17542 | |2;audio-dft;160;161;160;160;161;161;160;158;160;159 03:31:35 INFO - PROCESS | 17542 | |3;audio-fft;76;78;76;185;77;73;74;76;156;76 03:31:35 INFO - PROCESS | 17542 | |4;audio-oscillator;92;92;148;92;92;93;150;92;92;149 03:31:35 INFO - PROCESS | 17542 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;117;116 03:31:35 INFO - PROCESS | 17542 | |6;imaging-darkroom;145;145;146;144;146;146;146;145;145;145 03:31:35 INFO - PROCESS | 17542 | |7;imaging-desaturate;95;95;94;95;94;94;95;94;95;94 03:31:35 INFO - PROCESS | 17542 | |8;json-parse-financial;54;54;55;55;55;56;58;76;54;53 03:31:35 INFO - PROCESS | 17542 | |9;json-stringify-tinderbox;57;58;58;59;58;57;57;57;57;57 03:31:35 INFO - PROCESS | 17542 | |10;stanford-crypto-aes;72;72;72;72;72;73;74;74;72;74 03:31:35 INFO - PROCESS | 17542 | |11;stanford-crypto-ccm;114;114;111;110;108;115;112;110;126;112 03:31:35 INFO - PROCESS | 17542 | |12;stanford-crypto-pbkdf2;166;159;160;157;162;165;163;162;159;157 03:31:35 INFO - PROCESS | 17542 | |13;stanford-crypto-sha256-iterative;67;66;64;66;65;74;65;64;65;65 03:31:35 INFO - PROCESS | 17542 | __end_tp_report 03:31:35 INFO - PROCESS | 17542 | __start_cc_report 03:31:35 INFO - PROCESS | 17542 | _x_x_mozilla_cycle_collect,1634 03:31:35 INFO - PROCESS | 17542 | __end_cc_report 03:31:35 INFO - PROCESS | 17542 | __startTimestamp1464431495680__endTimestamp 03:31:35 INFO - PROCESS | 17542 | 03:31:35 INFO - PROCESS | 17542 | ------- Summary: start ------- 03:31:35 INFO - PROCESS | 17542 | Number of tests: 14 03:31:35 INFO - PROCESS | 17542 | 03:31:35 INFO - PROCESS | 17542 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:1.60 (1.5%) stddev-sans-first:1.50 03:31:35 INFO - PROCESS | 17542 | Values: 112.0 110.0 110.0 110.0 111.0 110.0 106.0 111.0 110.0 109.0 03:31:35 INFO - PROCESS | 17542 | 03:31:35 INFO - PROCESS | 17542 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:153.50 stddev:18.87 (12.3%) stddev-sans-first:20.00 03:31:35 INFO - PROCESS | 17542 | Values: 151.0 130.0 155.0 182.0 126.0 153.0 154.0 131.0 174.0 135.0 03:31:35 INFO - PROCESS | 17542 | 03:31:35 INFO - PROCESS | 17542 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 03:31:35 INFO - PROCESS | 17542 | Values: 160.0 161.0 160.0 160.0 161.0 161.0 160.0 158.0 160.0 159.0 03:31:35 INFO - PROCESS | 17542 | 03:31:35 INFO - PROCESS | 17542 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:40.55 (53.4%) stddev-sans-first:42.45 03:31:35 INFO - PROCESS | 17542 | Values: 76.0 78.0 76.0 185.0 77.0 73.0 74.0 76.0 156.0 76.0 03:31:35 INFO - PROCESS | 17542 | 03:31:35 INFO - PROCESS | 17542 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:92.00 stddev:27.47 (29.9%) stddev-sans-first:28.42 03:31:35 INFO - PROCESS | 17542 | Values: 92.0 92.0 148.0 92.0 92.0 93.0 150.0 92.0 92.0 149.0 03:31:35 INFO - PROCESS | 17542 | 03:31:35 INFO - PROCESS | 17542 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:31:35 INFO - PROCESS | 17542 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 03:31:35 INFO - PROCESS | 17542 | 03:31:35 INFO - PROCESS | 17542 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 03:31:35 INFO - PROCESS | 17542 | Values: 145.0 145.0 146.0 144.0 146.0 146.0 146.0 145.0 145.0 145.0 03:31:35 INFO - PROCESS | 17542 | 03:31:35 INFO - PROCESS | 17542 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 03:31:35 INFO - PROCESS | 17542 | Values: 95.0 95.0 94.0 95.0 94.0 94.0 95.0 94.0 95.0 94.0 03:31:35 INFO - PROCESS | 17542 | 03:31:35 INFO - PROCESS | 17542 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:55.00 stddev:6.82 (12.4%) stddev-sans-first:7.14 03:31:35 INFO - PROCESS | 17542 | Values: 54.0 54.0 55.0 55.0 55.0 56.0 58.0 76.0 54.0 53.0 03:31:35 INFO - PROCESS | 17542 | 03:31:35 INFO - PROCESS | 17542 | [#9] json-stringify-tinderbox Cycles:10 Average:57.50 Median:57.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 03:31:35 INFO - PROCESS | 17542 | Values: 57.0 58.0 58.0 59.0 58.0 57.0 57.0 57.0 57.0 57.0 03:31:35 INFO - PROCESS | 17542 | 03:31:35 INFO - PROCESS | 17542 | [#10] stanford-crypto-aes Cycles:10 Average:72.70 Median:72.50 stddev:0.95 (1.3%) stddev-sans-first:0.97 03:31:35 INFO - PROCESS | 17542 | Values: 72.0 72.0 72.0 72.0 72.0 73.0 74.0 74.0 72.0 74.0 03:31:35 INFO - PROCESS | 17542 | 03:31:35 INFO - PROCESS | 17542 | [#11] stanford-crypto-ccm Cycles:10 Average:113.20 Median:113.00 stddev:4.98 (4.4%) stddev-sans-first:5.28 03:31:35 INFO - PROCESS | 17542 | Values: 114.0 114.0 111.0 110.0 108.0 115.0 112.0 110.0 126.0 112.0 03:31:35 INFO - PROCESS | 17542 | 03:31:35 INFO - PROCESS | 17542 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:162.00 stddev:3.13 (1.9%) stddev-sans-first:2.74 03:31:35 INFO - PROCESS | 17542 | Values: 166.0 159.0 160.0 157.0 162.0 165.0 163.0 162.0 159.0 157.0 03:31:35 INFO - PROCESS | 17542 | 03:31:35 INFO - PROCESS | 17542 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:65.50 stddev:2.92 (4.5%) stddev-sans-first:3.08 03:31:35 INFO - PROCESS | 17542 | Values: 67.0 66.0 64.0 66.0 65.0 74.0 65.0 64.0 65.0 65.0 03:31:35 INFO - PROCESS | 17542 | -------- Summary: end -------- 03:31:35 INFO - PROCESS | 17542 | 03:31:36 INFO - TEST-INFO | 17542: exit 0 03:31:36 INFO - TEST-OK | kraken | took 60010ms 03:31:36 INFO - SUITE-END | took 1171s 03:31:36 INFO - Completed test suite (00:19:31) 03:31:36 INFO - javascript benchmark 03:31:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3313.1220226639944, 3354.379439803635, 3369.1913940654235, 3378.7465940054503, 3407.1311815487047, 5470.726463676815, 5485.61600687952, 5494.532964697995, 5497.532709719669, 5508.394076651565, 5477.260569823073, 5516.806911758089, 5532.336119665646, 5539.0, 5565.554755619551, 4948.529889660485, 4961.776720047606, 5012.04771093491, 5060.190369540875, 5103.795848166069, 4982.651214414992, 5047.369078865142, 5052.9747351263195, 5056.342675452204, 5058.038972595214, 5068.46781087986, 5139.486051394868, 5158.742062896859, 5160.045391602565, 5190.377154741436, 5162.638615296931, 5168.9224661630105, 5185.844424667228, 5189.974050129726, 5213.061648903196, 4902.779374928136, 4998.900021999576, 5007.69953802773, 5075.4163271223915, 5083.567896728782, 5359.088954877641, 5409.080456322435, 5413.756380962826, 5423.186522021689, 5440.6735595864375, 5927.170196172539, 5956.940430595682, 5961.612495187842, 5961.672108034057, 5966.0, 5979.850503737398, 5987.371326010793, 6075.362086980847, 6088.025915853486, 6097.02447608385, 5624.240727501776, 5654.519365853907, 5671.886562268732, 5673.574481913873, 5705.5435565154685, 6029.758809647565, 6147.047207682816, 6182.072689096672, 6186.81439556805, 6188.0717892315615, 5763.625364351387, 5818.941810581925, 5841.269841269841, 5842.269716285465, 5853.7365818538265, 5924.31870334917, 5931.703414829241, 5939.049752039653, 5942.970285148546, 5947.018741907536, 5821.417858214145, 5922.378150294243, 5936.643801371932, 5942.554308426886, 5951.553633477506, 5936.109583562414, 5970.6417614942375, 5975.073863551156, 5980.641161530322, 6020.69896505173, 4541.069080838421, 4542.909141817145, 4555.886102847456, 4559.840405585855, 4581.9541804582195, 4007.3988901664984, 4010.979945100256, 4063.9390409143884, 4065.7560546367313, 4117.1765646870745, 5649.491545760901, 5654.6324488908085, 5665.631733937281, 5672.432756724294, 5678.914816277759, 5943.821685349447, 5946.881062378815, 5947.791827286024, 5967.104934259809, 5967.224260846149, 5503.422140675251, 5551.056320425457, 5587.161925711176, 5641.830745077655, 5664.631798933056, 5115.2071428928575, 5117.257997590328, 5128.230765385222, 5152.484751524892, 5172.069027574998, 6204.317525072239, 6238.064290356483, 6243.625382477066, 6244.781432649836, 6254.0, 5769.509591684754, 5991.490723288569, 6023.909641355383, 6098.664573448503, 6124.54065945047, 6217.347178546368, 6219.036049412348, 6228.408301211378, 6236.220472440945, 6259.0, 5888.558358123244, 5889.764409423575, 5898.262717160355, 5907.261592300963, 5921.6743079131065, 5804.6807425592, 5874.236349274567, 5989.401059893976, 6014.007688731311, 6024.578279520391, 5908.615939963888, 5921.230240068763, 5938.287405511366, 5938.762449501972, 5948.929192745348, 5863.2670916135485, 5883.470487656132, 5905.704714764331, 5919.526437884872, 5925.555583331181, 5656.236408084856, 5731.684757338387, 5769.567282453917, 5806.912896306643, 5821.27234095738, 5834.504067154339, 5863.560232982629, 5877.529797616095, 5878.2064421302575, 5883.0881213410275, 5587.385387607441, 5749.338826035059, 5753.482186603226, 5764.942350576441, 5784.074548072288], "value": 5507.803306740425, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.7477846693622, 661.708848106833, 663.5189487621471, 663.6681659170416, 673.5689158938284, 29280.560791588145, 29872.551911721286, 29880.551791723115, 29921.40157196855, 29946.0, 34990.125246868774, 35108.824455877686, 35269.82365088177, 35312.47031294526, 35493.112672183146, 8540.274076703472, 8656.091110433408, 8705.825883482326, 8708.129187081273, 8717.476951382905, 8100.2304781045705, 8672.046074931752, 8850.5574721264, 10276.691699249035, 10487.108595769369, 10538.47307634619, 10630.46847657618, 10637.414942178177, 10642.308249963728, 10642.680719578426, 10221.437820919846, 10280.177585793119, 10280.48597570126, 10286.537105830255, 10298.691039268833, 10013.198944084528, 10039.34744241622, 10086.596536138546, 10088.94955525225, 10101.090901818872, 34392.656073439444, 34796.956091317305, 36967.0, 36973.63026369729, 37032.814835925914, 3392.4402473592077, 3404.710599599037, 3484.9303013939834, 3519.7360197985254, 3762.6801721853676, 30177.396452070836, 30281.0, 30378.84810575955, 30527.236819079477, 31959.840200798848, 4473.597376236155, 4498.8425405110665, 4513.977430112828, 4570.063137056929, 4594.150082234763, 277393.0, 282590.0, 283813.58093209605, 283870.0, 284240.0, 34255.828720856734, 34742.30515389678, 49547.25679114816, 50310.74844625754, 50397.0, 33343.83328083344, 33406.49890251648, 33485.33029339399, 33587.66412335894, 33590.16024599356, 13320.866791331962, 13341.66645833862, 13373.0, 13482.93258533701, 13489.662758431117, 9993.0, 10775.892241077645, 10821.783564328827, 10821.783564328827, 10921.945390273157, 8246.257836794717, 8321.334293256525, 8354.830323754679, 8373.120822313691, 8393.790155246046, 3235.7573182010974, 3264.4124057669374, 3278.9672103278663, 3286.901392958215, 3341.61571419285, 983.5279066048337, 1027.5427434791445, 1032.0969151992008, 1051.395447617623, 1081.7187531241777, 26255.868720656657, 26293.0, 26807.597886031726, 27070.729292707216, 27401.725982739918, 1085.4518468173521, 1090.4384242115316, 1135.006868989634, 1159.1827761428174, 1185.466540056978, 15105.169215693022, 15402.537923862303, 15481.5355539334, 15507.302171402314, 15763.842361576466, 461081.0, 518779.0, 527668.0, 527903.0, 528785.0, 47061.76469117632, 47443.76278118656, 47916.28125578119, 48251.75874120677, 48259.276110858365, 1339.77223871942, 1408.9929550352183, 1429.335359058043, 1441.8558144185708, 1446.5298777897226, 27057.458850823266, 29281.707182927898, 29742.55386169166, 30276.394472110875, 30903.072907812802, 42745.1450970985, 43097.13805723931, 43174.568254317055, 43467.347989780814, 43578.0, 341415.0, 343699.0, 343910.0, 344889.0, 344969.0, 25395.98416063337, 27494.0, 27882.721172788824, 28147.296317592223, 28197.0, 38458.23083538258, 38794.0, 38990.80504597459, 39204.21591568096, 39363.409548857366, 33976.490352644236, 34749.82625086858, 35253.0, 35480.0, 36281.27437451289, 34332.656673432946, 35007.0, 35482.0, 35569.1107722309, 35619.64380356267, 34836.651633484355, 35100.82449587736, 35527.11182220362, 35596.82201588975, 36617.0, 30818.691813081583, 32049.359012819146, 32228.677713223504, 32328.676713232566, 32532.51201231936, 25496.872515637304, 26002.479950400506, 26131.869340653175, 26767.0, 27722.0], "value": 17449.099030121597, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.44049212087316, 407.74719673802247, 410.64889519460843, 416.6063070398475, 421.66753060329347, 16505.504834854975, 16748.330066797327, 17409.564760880985, 17431.738523922137, 18178.363757268497, 12965.092443528956, 13617.387217575208, 14960.102393856376, 15489.922550387233, 15788.921055394736, 5356.1697936819755, 5555.611107222476, 5584.553235741131, 5590.273264475612, 5599.7480113394995, 5301.920471192935, 5429.294191755066, 5506.889862202754, 5530.917036244459, 5537.916931246034, 5488.039593071217, 5489.231507588941, 5504.834854954358, 5515.61390702651, 5518.061929471979, 5455.18172274158, 5466.098093814516, 5467.261919640838, 5702.600817942745, 6085.4827339676185, 5468.644538105011, 5490.890182196334, 5510.090835012218, 5511.58663100269, 5517.200005999108, 18890.52773680655, 20422.387328380173, 20590.691139632916, 20716.89641551798, 20835.16659333625, 2400.303911865557, 2457.0, 2480.0203919451715, 2930.985345073282, 3081.599392079038, 9980.101790838788, 10263.538140783683, 10308.484575771256, 10431.79136417275, 10569.841452378221, 1950.8634395592314, 1971.3691618682028, 2099.8950052497466, 2132.115172203534, 2165.902534385956, 75004.0, 78173.0, 81033.59483202605, 81798.18201818025, 84277.57861210716, 10105.29262951601, 10417.895821041693, 10607.94696026515, 10816.729581760519, 10917.344959302467, 13381.130226535244, 13582.185068895898, 13601.115927464882, 13613.591592252249, 13614.795778063337, 7153.89269160963, 7425.554466732014, 7472.5516469010945, 7505.211952744883, 7540.811479712941, 7142.107236595426, 7220.963895180491, 7242.167150777623, 7255.23819998903, 7421.2949769771785, 4299.333603291495, 4506.039872655406, 4567.314902764612, 4793.089313030583, 5070.746462676925, 1897.155765684285, 1908.9236430542624, 1918.424472658197, 1926.258390519632, 2027.3715148303777, 889.888763904512, 901.7925877048316, 920.40173886974, 941.4962994797751, 974.4640447753707, 16453.58866028359, 16650.417235396704, 16673.416430424877, 16863.0, 17113.743293850603, 948.8376738495288, 957.2916042128913, 966.2897770139083, 973.6689525561343, 1027.0345874877592, 7039.859202816017, 9406.717798466058, 9539.379940303857, 9590.952045239728, 9664.178544823768, 499610.0, 504752.0, 515330.0, 516017.0, 518733.0, 54904.72547637236, 78463.21536784673, 87713.0, 88360.0, 92282.0771792287, 939.0797018921495, 963.272729089533, 964.3056998960737, 967.8209531236744, 978.4325091446801, 14982.325795339453, 14987.850121498646, 15257.660167131184, 15271.61820954485, 15327.157006364758, 39431.80284098561, 39713.60286397099, 39930.80034599808, 40613.59386406098, 40983.0, 57474.7126264366, 58963.41036589751, 59026.0, 59069.704651476466, 59089.0, 8888.244499217639, 8897.555122243732, 8979.119832918954, 8992.415492992934, 9073.183413492818, 9405.905940940776, 9578.521073946136, 9595.760105997406, 9854.310198286337, 9920.900790991998, 8664.393492455467, 8784.472931624123, 8796.208341249318, 8835.285736900418, 8936.821263574822, 8790.956045219733, 8972.41679290844, 9045.0, 9208.355415120877, 9272.258219342571, 7507.512011719221, 7660.004199454035, 9092.181703646704, 9290.535473226448, 9402.059794020543, 12269.93865030669, 12684.492620295454, 12694.555690550786, 12703.745925081632, 12928.741425171633, 12296.692582685504, 12361.814572781235, 12400.937995309965, 12563.497460101493, 12578.119531632698], "value": 8683.989902176952, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1240.8262843201949, 1420.9715805683884, 1462.4881291547956, 1555.9377624895005, 1739.956501087472, 7371.741989030378, 8175.059868115169, 8288.91711082889, 8304.792380190498, 8327.958360208191, 8169.59152042397, 8315.75052748417, 8318.126596707334, 8320.875186872201, 8339.45793523422, 2125.0968338456173, 2176.1730542393866, 2380.9166679166233, 2411.565918134735, 2429.854208747472, 2374.323317854412, 2411.5418070566625, 2412.7587241275905, 2413.456972181254, 2414.95170096598, 2360.3391050505884, 2405.4106743847783, 2406.8916898739512, 2408.7350391456926, 2409.4819613783034, 2083.2083808152956, 2326.3718795925174, 2358.9738463768317, 2374.513224788914, 2405.6391541268777, 2319.060780383947, 2338.275134708246, 2359.2686267257204, 2360.2565191964477, 2360.7521210273017, 8021.117677055519, 8134.471259368122, 8136.511809291462, 8138.674453021872, 8140.9592952035455, 5185.870353241162, 5257.76340064698, 5295.7881684732565, 5300.734963251861, 5303.284056652341, 3469.2541103662834, 3499.2826470573473, 3526.5239192708914, 3556.8399422026073, 3560.893173204808, 1088.970808010357, 1164.0687450040018, 1174.1604752601932, 1184.2006645514243, 1197.4012993503247, 12100.878991210064, 12251.877481225163, 12256.754864902652, 12331.568395106218, 12370.62888113349, 4733.05359734867, 4789.401324834395, 4822.132016237111, 4837.685550439211, 4891.5353041461, 10018.599256029824, 10063.899361006443, 10072.294939354322, 10083.0, 10085.69742907714, 5336.1462166054025, 5399.568034557226, 5405.054115529767, 5407.351117865881, 5408.269883565668, 4305.870823875289, 4742.454617718938, 4820.927686084711, 4825.565699087099, 4830.951690483121, 4077.55146933837, 4082.755034697928, 4120.75275483472, 4190.371444283321, 4280.59334363235, 1323.9801402978962, 1337.8862796662197, 1339.8392192936715, 1342.5770882172085, 1360.6054244269249, 788.8895554622358, 833.3125171733344, 877.140402405646, 896.6906417286026, 908.1962463220098, 5611.268391881635, 5672.7730890763905, 5731.226284451629, 5733.0, 5854.941450585525, 1007.6271779441654, 1028.1620479309488, 1047.2302857399804, 1048.895110488945, 1055.567217440861, 3771.41543060826, 3774.452704357853, 3784.924301513954, 3787.9431808522895, 3837.520309961255, 10124.949375253076, 10165.135963443043, 10405.167586593054, 10534.894651053544, 10545.31455455393, 10337.638182663572, 10396.116330112025, 10434.0, 10441.582336706599, 10443.68668939933, 7846.607669616496, 8071.878921816177, 8072.233137851895, 8257.504549727035, 8262.049864265686, 5544.916826247529, 5574.275344205227, 5602.579806514446, 5615.241942337732, 5623.240862483676, 9481.52592370365, 9711.465869376969, 9719.416834989923, 9778.462184579916, 9796.951015244878, 9140.131687489678, 9531.809363812547, 9547.140757331874, 9868.161206297546, 9889.307748457826, 6917.792466226021, 7311.159216690149, 7475.551466912003, 7509.924900751141, 7629.7329593463965, 7945.682172713026, 7960.920390796018, 7980.0, 8014.679412823421, 8029.076656184614, 7264.455165862476, 7292.416606671348, 7340.669669864762, 7424.0, 7428.591427471325, 6884.311568843276, 7354.374878135419, 7389.593572353572, 7404.777856664308, 7512.098548174035, 6954.165500140016, 7019.894701579378, 7105.715771369088, 7138.0, 7152.964235178791, 4879.804807807648, 4882.389701287339, 4966.801327946841, 4975.925361119658, 5022.874428139326, 4994.1260279450225, 5053.545180933734, 5074.467180946095, 5134.255532947776, 5178.016176926372], "value": 4558.872089358515, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.0803159973667, 366.1468777747848, 367.08229426433917, 373.0, 374.67590534187934, 6006.369331220225, 6093.512518998475, 6147.415995480428, 6181.505479561635, 6202.9999999999945, 6156.476699480539, 6214.751409943597, 6214.751409943608, 6221.471174950123, 6226.43962043416, 4577.153226653079, 4665.930011049837, 4709.411323584552, 4766.5471780180915, 4789.257665061921, 4783.641226907996, 4788.616910647157, 4793.32893394925, 4797.0645724083815, 4798.04039192163, 4759.524047595248, 4760.642951778613, 4766.833160839371, 4775.80896764129, 4778.856634300959, 4764.642651801111, 4766.046790641885, 4770.356001939763, 4773.880652983703, 4775.761211939423, 4218.873433796991, 4219.493660760698, 4225.176090662322, 4238.406623072772, 4238.554951730086, 5744.22452968848, 5919.260092488439, 5958.672273024982, 5958.851028724273, 5968.641881487125, 5416.83749487516, 5427.83716488506, 5443.346798384219, 5444.754986025639, 5471.616986810925, 6502.967485162591, 6506.1216735740545, 6510.18622672166, 6515.609063456208, 6527.93472065278, 4426.136903303857, 4507.639388848885, 4529.796159172845, 4588.908221835544, 4591.977040114812, 6688.899666505006, 6748.460123190133, 6763.053172555895, 6774.220964589086, 6779.186497620268, 4635.119327327797, 4636.072785442858, 4639.628829693616, 4642.0, 4643.930341044887, 4694.037722266927, 4696.272077827942, 4696.976515117402, 4699.553542413465, 4703.223968045303, 5145.382554093533, 5276.683398995996, 5374.328208973879, 5425.755840987165, 5428.5114339708825, 6454.774082907075, 6514.218293804774, 6516.902246466307, 6532.575382600211, 6548.0177973303435, 1641.4501142117524, 1663.9584010399594, 1666.4833901490576, 1667.1080971680092, 1668.0992264177207, 1075.1936047964027, 1092.0990183098975, 1093.03812644872, 1110.4947249001684, 1113.204059097749, 6339.492840572743, 6345.428911397997, 6360.6501642409185, 6364.586301890362, 6368.29948705642, 6745.56153850008, 6746.0892779475125, 6748.595084294958, 6749.561278516979, 6784.219814721271, 6288.402601752826, 6349.206349206349, 6354.936450635434, 6358.3641635836975, 6361.936380636227, 3599.3341231872187, 3629.927401451956, 3631.3463576555946, 3634.83643236055, 3637.4907512948207, 6837.931620683829, 6864.347886950732, 6905.516613836983, 6985.860282794417, 6990.335918087773, 6851.3491218334175, 6859.451243900476, 6863.519553631198, 6866.759663411856, 6874.415674667609, 6951.860962780817, 6953.304669533006, 6961.686724097326, 6962.547434416747, 6980.057692211486, 6659.600423974577, 6706.094677218513, 6711.63086030273, 6712.429443497357, 6717.093192418961, 6473.158489396536, 6620.172478440195, 6623.635700036351, 6624.834379140368, 6628.304028077176, 6800.353966373186, 6830.282820303995, 6846.110005699426, 6847.6576171190245, 6849.075374824534, 4678.766061696833, 4679.859604211879, 4687.460941991714, 4689.062187562433, 4694.037722266995, 6456.160699109086, 6540.411362977355, 6670.733170673118, 6674.798536263519, 6678.799636010927, 6443.0, 6565.606063636006, 6574.934250657432, 6584.374484423972, 6665.366790154928, 6521.902171467526, 6531.11829902976, 6533.869322613426, 6538.411542961157, 6554.705038273194, 6434.67826608677, 6435.549511534147, 6440.549161558646, 6443.548951573533, 6443.677816109082, 6460.224773027267, 6589.703463344257, 6599.439047681001, 6602.207735071822, 6604.636744979072, 6419.325970773001, 6436.066770318372, 6442.903356449563, 6443.0, 6446.645434501147], "value": 4942.385354894542, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.4937495628192, 741.9962900185502, 746.7908985484066, 752.3980815347722, 766.7354762606902, 14275.0, 14419.279036048209, 14434.0, 14471.34878930448, 14471.855281447195, 12880.227186368824, 12973.675658108528, 12978.870211297884, 12984.415701293441, 13003.0, 542.2950164785782, 606.3905774696424, 613.2181468627502, 616.0758861707438, 617.3271134463456, 620.618319733363, 625.2715586341906, 626.1234272019187, 628.2617923939375, 630.8927482327992, 635.4820821030868, 637.3849235487753, 638.7061951502315, 638.881806865729, 640.0974625777654, 558.4359796605437, 624.7001439309134, 629.9527535434838, 643.0803950350996, 651.7849109793757, 478.63862783598506, 479.302614695617, 481.67005601163316, 481.6796830107974, 482.3440121434846, 13545.39045742944, 13592.0, 13595.116317439335, 13601.931990340085, 13613.591592252149, 13816.240106794123, 14182.929085354508, 14195.0, 14223.28883555818, 14250.429982800675, 11923.821142682868, 12316.876831231662, 12470.309377525844, 12650.620481385573, 13001.544945926848, 3907.2966865964113, 3967.4842270504937, 4006.3790112532606, 4007.6593489553425, 4021.0, 58860.41139588592, 59249.0, 59794.70102649502, 60225.69887150536, 60358.69820650913, 10370.844437333446, 10394.16846652266, 10417.42704151279, 10483.47582620866, 10694.518746656418, 17901.7314740279, 17922.372716954844, 17923.910380448015, 17963.0, 17971.101444927703, 8385.538795366314, 8413.116622754522, 8481.660733570712, 8522.829543409222, 8574.356923230782, 4867.148249056401, 4898.167311557044, 4942.382202224722, 4998.925016124761, 5013.573846223112, 3286.3920174767745, 3299.983500082484, 3320.6015278166774, 3337.332533493311, 3342.766006379579, 579.6087640842414, 583.9211706419663, 593.6111846740392, 600.3966014155745, 608.4219991008559, 598.8862116197909, 657.8947368421029, 690.6650274616807, 718.2996578336185, 749.6439191384048, 9610.6664023197, 9974.102330790118, 9993.050660187271, 9996.150327222122, 10170.847437288447, 663.4062514049898, 704.5913370245348, 718.90294810201, 768.3584207187062, 772.7874834420579, 4329.295759309763, 4365.345198220292, 4432.49026361966, 4525.932111018337, 4595.448546174481, 64360.678196608715, 66106.0, 66523.33476665268, 67199.32800672029, 67221.0, 57223.0, 57734.845303094546, 58256.0, 58387.416125839045, 58756.41243587509, 47680.28479572809, 49094.75452622786, 51967.0, 53116.73441632767, 53590.196147057824, 9984.722828459107, 10179.694609161737, 10278.691639250834, 10285.485725713535, 10397.11624511925, 38384.42423363596, 38716.225675486894, 38824.611753883226, 38830.805845970586, 39808.40287395634, 45419.318710218715, 46530.767346163055, 49819.50180498149, 51081.489185107675, 52937.735311323195, 11531.1351648625, 11624.94187529057, 11650.067994560584, 11655.358955257543, 12185.756284874431, 14039.929800350932, 14304.57086287413, 14341.139531628136, 14362.856371436152, 14449.277536123362, 12825.422855971317, 13301.401436935168, 13314.800277995644, 13674.179549227078, 13812.516561920285, 12879.678008049874, 12923.806142908052, 12940.417681204557, 12946.616641968316, 12997.310627487384, 13049.0, 13123.409446575119, 13147.408366623333, 13312.866871331164, 13340.132891362031, 11279.7744045117, 11405.20163588574, 11466.0, 11630.302181869114, 11631.243969142317, 11116.49975751077, 11182.944085279521, 11280.32318060919, 11333.489992950172, 11354.602588909678], "value": 6626.842311927213, "unit": "score"}], "name": "dromaeo_css", "value": 7067.527668858138, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 110.0, 110.0, 111.0, 110.0, 106.0, 111.0, 110.0, 109.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 130.0, 155.0, 182.0, 126.0, 153.0, 154.0, 131.0, 174.0, 135.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 161.0, 161.0, 160.0, 158.0, 160.0, 159.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 185.0, 77.0, 73.0, 74.0, 76.0, 156.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 148.0, 92.0, 92.0, 93.0, 150.0, 92.0, 92.0, 149.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 144.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 55.0, 55.0, 56.0, 58.0, 76.0, 54.0, 53.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 59.0, 58.0, 57.0, 57.0, 57.0, 57.0, 57.0], "value": 57.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 72.0, 72.0, 73.0, 74.0, 74.0, 72.0, 74.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 111.0, 110.0, 108.0, 115.0, 112.0, 110.0, 126.0, 112.0], "value": 113.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 159.0, 160.0, 157.0, 162.0, 165.0, 163.0, 162.0, 159.0, 157.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 64.0, 66.0, 65.0, 74.0, 65.0, 64.0, 65.0, 65.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1506.9, "alertThreshold": 2.0}]} 03:31:36 INFO - Return code: 0 03:31:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:31:37 ERROR - # TBPL SUCCESS # 03:31:37 INFO - Running post-action listener: _resource_record_post_action 03:31:37 INFO - Running post-run listener: _resource_record_post_run 03:31:38 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 505655296; Read time: 20; Write time: 532228 03:31:38 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 255758336; Read time: 0; Write time: 351224 03:31:38 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 249896960; Read time: 20; Write time: 181004 03:31:38 INFO - Running post-run listener: _upload_blobber_files 03:31:38 INFO - Blob upload gear active. 03:31:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:31:38 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:31:38 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:31:38 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:31:38 INFO - (blobuploader) - INFO - Open directory for files ... 03:31:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:31:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:31:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:31:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:31:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:31:39 INFO - (blobuploader) - INFO - Done attempting. 03:31:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:31:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:31:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:31:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:31:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:31:40 INFO - (blobuploader) - INFO - Done attempting. 03:31:40 INFO - (blobuploader) - INFO - Iteration through files over. 03:31:40 INFO - Return code: 0 03:31:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:31:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:31:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7bda61abc37a9625d09b903d33995034f7089d19390032d4e0e8ec3815612f46812aed04d7366dbb7eaff6a97b08ebb408e99066efc34514bc9c0e6a9fda7bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b38b2b738aedf9ff39790f44670f65e72a15d9610b5df687b8917a0508ff4f054bb845e2ebdf9b6067e9e2dc1ea1ac2ca17da1269cc3d4c4ffc5aa948732efc"} 03:31:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:31:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:31:40 INFO - Contents: 03:31:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7bda61abc37a9625d09b903d33995034f7089d19390032d4e0e8ec3815612f46812aed04d7366dbb7eaff6a97b08ebb408e99066efc34514bc9c0e6a9fda7bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b38b2b738aedf9ff39790f44670f65e72a15d9610b5df687b8917a0508ff4f054bb845e2ebdf9b6067e9e2dc1ea1ac2ca17da1269cc3d4c4ffc5aa948732efc"} 03:31:40 INFO - Running post-run listener: copy_logs_to_upload_dir 03:31:40 INFO - Copying logs to upload dir... 03:31:40 INFO - mkdir: /builds/slave/test/build/upload/logs 03:31:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.782720 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-28 03:31:40.670791) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:31:40.674154) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808 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/b7bda61abc37a9625d09b903d33995034f7089d19390032d4e0e8ec3815612f46812aed04d7366dbb7eaff6a97b08ebb408e99066efc34514bc9c0e6a9fda7bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b38b2b738aedf9ff39790f44670f65e72a15d9610b5df687b8917a0508ff4f054bb845e2ebdf9b6067e9e2dc1ea1ac2ca17da1269cc3d4c4ffc5aa948732efc"} build_url:https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011247 build_url: 'https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/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/b7bda61abc37a9625d09b903d33995034f7089d19390032d4e0e8ec3815612f46812aed04d7366dbb7eaff6a97b08ebb408e99066efc34514bc9c0e6a9fda7bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b38b2b738aedf9ff39790f44670f65e72a15d9610b5df687b8917a0508ff4f054bb845e2ebdf9b6067e9e2dc1ea1ac2ca17da1269cc3d4c4ffc5aa948732efc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:31:40.699282) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:31:40.699603) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1464430266.980238-1258378808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:31:40.783780) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:31:40.784099) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:31:40.784405) ========= ========= Total master_lag: 0.17 =========