builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1464629624.18 results: success (0) buildid: 20160530075343 builduid: 347dbc64cac343d6901446652388f9f8 revision: de472f31c8a3f1711bdf65beecc8dfa983950b64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 10:33:44.177215) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 10:33:44.177700) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 10:33:44.177995) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 10:33:44.192443) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:33:44.192773) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 10:33:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-05-30 10:33:44 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077290 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:33:44.285426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:33:44.285928) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020428 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:33:44.338162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:33:44.338782) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev de472f31c8a3f1711bdf65beecc8dfa983950b64 --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 de472f31c8a3f1711bdf65beecc8dfa983950b64 --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=5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 10:33:44,609 truncating revision to first 12 chars 2016-05-30 10:33:44,609 Setting DEBUG logging. 2016-05-30 10:33:44,609 attempt 1/10 2016-05-30 10:33:44,609 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/de472f31c8a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 10:33:44,932 unpacking tar archive at: mozilla-aurora-de472f31c8a3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636582 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:33:44.991453) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 10:33:44.991812) ========= script_repo_revision: de472f31c8a3f1711bdf65beecc8dfa983950b64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 10:33:44.992216) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 10:33:44.992519) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 10:33:45.003925) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-05-30 10:33:45.004540) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:33:45 INFO - MultiFileLogger online at 20160530 10:33:45 in /builds/slave/test 10:33:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:33:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:33:45 INFO - {'append_to_log': False, 10:33:45 INFO - 'base_work_dir': '/builds/slave/test', 10:33:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:33:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:33:45 INFO - 'branch': 'Mozilla-Aurora', 10:33:45 INFO - 'buildbot_json_path': 'buildprops.json', 10:33:45 INFO - 'config_files': ('talos/linux_config.py',), 10:33:45 INFO - 'default_actions': ('clobber', 10:33:45 INFO - 'read-buildbot-config', 10:33:45 INFO - 'download-and-extract', 10:33:45 INFO - 'populate-webroot', 10:33:45 INFO - 'create-virtualenv', 10:33:45 INFO - 'install', 10:33:45 INFO - 'run-tests'), 10:33:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:33:45 INFO - 'download_minidump_stackwalk': True, 10:33:45 INFO - 'download_symbols': 'ondemand', 10:33:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:33:45 INFO - 'tooltool.py': '/tools/tooltool.py', 10:33:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:33:45 INFO - '/tools/misc-python/virtualenv.py')}, 10:33:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:33:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:33:45 INFO - 'installer_path': 'installer.exe', 10:33:45 INFO - 'log_level': 'info', 10:33:45 INFO - 'log_name': 'talos', 10:33:45 INFO - 'log_to_console': True, 10:33:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:33:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:33:45 INFO - 'opt_config_files': (), 10:33:45 INFO - 'pip_index': False, 10:33:45 INFO - 'sps_profile': False, 10:33:45 INFO - 'sps_profile_interval': 0, 10:33:45 INFO - 'suite': 'dromaeojs-e10s', 10:33:45 INFO - 'system_bits': '32', 10:33:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:33:45 INFO - 'title': 'talos-linux64-ix-051', 10:33:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:33:45 INFO - 'use_talos_json': True, 10:33:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:33:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:33:45 INFO - 'work_dir': 'build'} 10:33:45 INFO - ##### 10:33:45 INFO - ##### Running clobber step. 10:33:45 INFO - ##### 10:33:45 INFO - Running pre-action listener: _resource_record_pre_action 10:33:45 INFO - Running main action method: clobber 10:33:45 INFO - rmtree: /builds/slave/test/build 10:33:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:33:45 INFO - Running post-action listener: _resource_record_post_action 10:33:45 INFO - ##### 10:33:45 INFO - ##### Running read-buildbot-config step. 10:33:45 INFO - ##### 10:33:45 INFO - Running pre-action listener: _resource_record_pre_action 10:33:45 INFO - Running main action method: read_buildbot_config 10:33:45 INFO - Using buildbot properties: 10:33:45 INFO - { 10:33:45 INFO - "project": "", 10:33:45 INFO - "product": "firefox", 10:33:45 INFO - "script_repo_revision": "production", 10:33:45 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 10:33:45 INFO - "repository": "", 10:33:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 10:33:45 INFO - "buildid": "20160530075343", 10:33:45 INFO - "pgo_build": "True", 10:33:45 INFO - "basedir": "/builds/slave/test", 10:33:45 INFO - "buildnumber": 310, 10:33:45 INFO - "slavename": "talos-linux64-ix-051", 10:33:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:33:45 INFO - "platform": "ubuntu64_hw", 10:33:45 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:33:45 INFO - "branch": "mozilla-aurora", 10:33:45 INFO - "repo_path": "releases/mozilla-aurora", 10:33:45 INFO - "revision": "de472f31c8a3f1711bdf65beecc8dfa983950b64", 10:33:45 INFO - "stage_platform": "linux64-pgo", 10:33:45 INFO - "builduid": "347dbc64cac343d6901446652388f9f8", 10:33:45 INFO - "slavebuilddir": "test" 10:33:45 INFO - } 10:33:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 10:33:45 INFO - Running post-action listener: _resource_record_post_action 10:33:45 INFO - ##### 10:33:45 INFO - ##### Running download-and-extract step. 10:33:45 INFO - ##### 10:33:45 INFO - Running pre-action listener: _resource_record_pre_action 10:33:45 INFO - Running main action method: download_and_extract 10:33:45 INFO - mkdir: /builds/slave/test/build/tests 10:33: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')]} 10:33:45 INFO - https://queue.taskcluster.net/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:33:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:33:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:33:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/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 10:33:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/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 10:33:46 INFO - Downloaded 1361 bytes. 10:33:46 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:33:46 INFO - Using the following test package requirements: 10:33:46 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:33:46 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:33:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:33:46 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:33:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:33:46 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:33:46 INFO - u'jsshell-linux-x86_64.zip'], 10:33:46 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:33:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:33:46 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:33:46 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:33:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:33:46 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:33:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:33:46 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:33:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:33:46 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:33:46 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:33:46 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:46 INFO - https://queue.taskcluster.net/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:33:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:33:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:33:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/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 10:33:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/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 10:33:47 INFO - Downloaded 24173574 bytes. 10:33:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:33:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:33:48 INFO - Return code: 0 10:33:48 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:48 INFO - https://queue.taskcluster.net/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:33:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:33:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:33:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/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 10:33:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/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 10:33:50 INFO - Downloaded 24173574 bytes. 10:33:50 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'] 10:33:50 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 10:33:51 INFO - Return code: 0 10:33:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:51 INFO - https://queue.taskcluster.net/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:33:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:33:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:33:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/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 10:33:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/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 10:33:53 INFO - Downloaded 10840145 bytes. 10:33:53 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'] 10:33:53 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 10:33:53 INFO - Return code: 0 10:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:53 INFO - https://queue.taskcluster.net/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:33:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:33:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:33:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/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 10:33:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHYNW5dNRR2z7jx_WNNEkg/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 10:33:54 INFO - Downloaded 62803140 bytes. 10:33:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:33:54 INFO - mkdir: /builds/slave/test/properties 10:33:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:33:54 INFO - Writing to file /builds/slave/test/properties/build_url 10:33:54 INFO - Contents: 10:33:54 INFO - build_url:https://queue.taskcluster.net/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:33:55 INFO - Running post-action listener: _resource_record_post_action 10:33:55 INFO - Running post-action listener: set_extra_try_arguments 10:33:55 INFO - ##### 10:33:55 INFO - ##### Running populate-webroot step. 10:33:55 INFO - ##### 10:33:55 INFO - Running pre-action listener: _resource_record_pre_action 10:33:55 INFO - Running main action method: populate_webroot 10:33:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:33:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:33:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:33:55 INFO - '--tppagecycles', 10:33:55 INFO - '7'], 10:33:55 INFO - 'tests': ['tsvgm']}}, 10:33:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:33:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:33:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:33:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:33:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:33:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:33:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:55 INFO - 'talos_options': ['--disable-e10s'], 10:33:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:33:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:33:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:55 INFO - 'talos_options': ['--disable-e10s'], 10:33:55 INFO - 'tests': ['damp', 'tps']}, 10:33:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:55 INFO - 'tests': ['damp', 'tps']}, 10:33:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:33:55 INFO - 'tests': ['dromaeo_dom']}, 10:33:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:33:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:33:55 INFO - 'tests': ['a11yr', 10:33:55 INFO - 'ts_paint', 10:33:55 INFO - 'tpaint', 10:33:55 INFO - 'sessionrestore', 10:33:55 INFO - 'sessionrestore_no_auto_restore', 10:33:55 INFO - 'tabpaint']}, 10:33:55 INFO - 'other-e10s': {'tests': ['a11yr', 10:33:55 INFO - 'ts_paint', 10:33:55 INFO - 'tpaint', 10:33:55 INFO - 'sessionrestore', 10:33:55 INFO - 'sessionrestore_no_auto_restore', 10:33:55 INFO - 'tabpaint']}, 10:33:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:33:55 INFO - 'ts_paint', 10:33:55 INFO - 'tpaint', 10:33:55 INFO - 'sessionrestore', 10:33:55 INFO - 'sessionrestore_no_auto_restore', 10:33:55 INFO - 'tabpaint']}, 10:33:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:33:55 INFO - 'ts_paint', 10:33:55 INFO - 'tpaint', 10:33:55 INFO - 'sessionrestore', 10:33:55 INFO - 'sessionrestore_no_auto_restore', 10:33:55 INFO - 'tabpaint']}, 10:33:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:33:55 INFO - 'tests': ['a11yr', 10:33:55 INFO - 'ts_paint', 10:33:55 INFO - 'tpaint', 10:33:55 INFO - 'sessionrestore', 10:33:55 INFO - 'sessionrestore_no_auto_restore', 10:33:55 INFO - 'tabpaint']}, 10:33:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:33:55 INFO - 'tests': ['a11yr', 10:33:55 INFO - 'ts_paint', 10:33:55 INFO - 'tpaint', 10:33:55 INFO - 'sessionrestore', 10:33:55 INFO - 'sessionrestore_no_auto_restore', 10:33:55 INFO - 'tabpaint']}, 10:33:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:33:55 INFO - 'tests': ['tsvgx', 10:33:55 INFO - 'tsvgr_opacity', 10:33:55 INFO - 'tart', 10:33:55 INFO - 'tscrollx', 10:33:55 INFO - 'cart']}, 10:33:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:33:55 INFO - 'tsvgr_opacity', 10:33:55 INFO - 'tart', 10:33:55 INFO - 'tscrollx', 10:33:55 INFO - 'cart']}, 10:33:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:55 INFO - 'talos_options': ['--disable-e10s'], 10:33:55 INFO - 'tests': ['tp5o']}, 10:33:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:55 INFO - 'tests': ['tp5o']}, 10:33:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:55 INFO - 'talos_options': ['--disable-e10s', 10:33:55 INFO - '--xperf_path', 10:33:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:33:55 INFO - 'tests': ['tp5n']}, 10:33:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:55 INFO - 'talos_options': ['--xperf_path', 10:33:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:33:55 INFO - 'tests': ['tp5n']}}, 10:33:55 INFO - 'talos.zip': {'path': '', 10:33:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:33:55 INFO - Running post-action listener: _resource_record_post_action 10:33:55 INFO - ##### 10:33:55 INFO - ##### Running create-virtualenv step. 10:33:55 INFO - ##### 10:33:55 INFO - Running pre-action listener: _resource_record_pre_action 10:33:55 INFO - Running main action method: create_virtualenv 10:33:55 INFO - Creating virtualenv /builds/slave/test/build/venv 10:33:55 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 10:33:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:33:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:33:55 INFO - Using real prefix '/usr' 10:33:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:33:56 INFO - Installing distribute.............................................................................................................................................................................................done. 10:33:58 INFO - Installing pip.................done. 10:33:58 INFO - Return code: 0 10:33:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb17381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4410>, '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 0x10f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f57a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', '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 10:33:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:33:58 INFO - Using env: {'DISPLAY': ':0', 10:33:58 INFO - 'HOME': '/home/cltbld', 10:33:58 INFO - 'LANG': 'en_US.UTF-8', 10:33:58 INFO - 'LANGUAGE': 'en_US:en', 10:33:58 INFO - 'LOGNAME': 'cltbld', 10:33:58 INFO - 'MAIL': '/var/mail/cltbld', 10:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:58 INFO - 'MOZ_NO_REMOTE': '1', 10:33:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:58 INFO - 'NO_EM_RESTART': '1', 10:33:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:58 INFO - 'PWD': '/builds/slave/test', 10:33:58 INFO - 'SHELL': '/bin/bash', 10:33:58 INFO - 'SHLVL': '1', 10:33:58 INFO - 'TERM': 'linux', 10:33:58 INFO - 'TMOUT': '86400', 10:33:58 INFO - 'USER': 'cltbld', 10:33:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', 10:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:58 INFO - '_': '/tools/buildbot/bin/python'} 10:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:58 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 10:33:58 INFO - Cleaning up... 10:33:58 INFO - Return code: 0 10:33:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7feb17381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4410>, '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 0x10f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f57a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', '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 10:33:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:33:58 INFO - Using env: {'DISPLAY': ':0', 10:33:58 INFO - 'HOME': '/home/cltbld', 10:33:58 INFO - 'LANG': 'en_US.UTF-8', 10:33:58 INFO - 'LANGUAGE': 'en_US:en', 10:33:58 INFO - 'LOGNAME': 'cltbld', 10:33:58 INFO - 'MAIL': '/var/mail/cltbld', 10:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:58 INFO - 'MOZ_NO_REMOTE': '1', 10:33:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:33:58 INFO - 'NO_EM_RESTART': '1', 10:33:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:58 INFO - 'PWD': '/builds/slave/test', 10:33:58 INFO - 'SHELL': '/bin/bash', 10:33:58 INFO - 'SHLVL': '1', 10:33:58 INFO - 'TERM': 'linux', 10:33:58 INFO - 'TMOUT': '86400', 10:33:58 INFO - 'USER': 'cltbld', 10:33:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', 10:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:58 INFO - '_': '/tools/buildbot/bin/python'} 10:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:58 INFO - Downloading/unpacking psutil>=0.7.1 10:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:34:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:34:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:34:00 INFO - Installing collected packages: psutil 10:34:00 INFO - Running setup.py install for psutil 10:34:00 INFO - building 'psutil._psutil_linux' extension 10:34:00 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 10:34:00 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 10:34:00 INFO - building 'psutil._psutil_posix' extension 10:34:00 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 10:34:00 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 10:34:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:34:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:34:01 INFO - Successfully installed psutil 10:34:01 INFO - Cleaning up... 10:34:01 INFO - Return code: 0 10:34:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7feb17381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4410>, '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 0x10f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f57a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', '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 10:34:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:34:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:34:01 INFO - Using env: {'DISPLAY': ':0', 10:34:01 INFO - 'HOME': '/home/cltbld', 10:34:01 INFO - 'LANG': 'en_US.UTF-8', 10:34:01 INFO - 'LANGUAGE': 'en_US:en', 10:34:01 INFO - 'LOGNAME': 'cltbld', 10:34:01 INFO - 'MAIL': '/var/mail/cltbld', 10:34:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:01 INFO - 'MOZ_NO_REMOTE': '1', 10:34:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:01 INFO - 'NO_EM_RESTART': '1', 10:34:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:01 INFO - 'PWD': '/builds/slave/test', 10:34:01 INFO - 'SHELL': '/bin/bash', 10:34:01 INFO - 'SHLVL': '1', 10:34:01 INFO - 'TERM': 'linux', 10:34:01 INFO - 'TMOUT': '86400', 10:34:01 INFO - 'USER': 'cltbld', 10:34:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', 10:34:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:01 INFO - '_': '/tools/buildbot/bin/python'} 10:34:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:34:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:34:03 INFO - Installing collected packages: mozsystemmonitor 10:34:03 INFO - Running setup.py install for mozsystemmonitor 10:34:03 INFO - Successfully installed mozsystemmonitor 10:34:03 INFO - Cleaning up... 10:34:03 INFO - Return code: 0 10:34:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:34:03 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')]} 10:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:03 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')]} 10:34:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:03 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 0x7feb17381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4410>, '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 0x10f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f57a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', '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 10:34:03 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 10:34:03 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 10:34:03 INFO - Using env: {'DISPLAY': ':0', 10:34:03 INFO - 'HOME': '/home/cltbld', 10:34:03 INFO - 'LANG': 'en_US.UTF-8', 10:34:03 INFO - 'LANGUAGE': 'en_US:en', 10:34:03 INFO - 'LOGNAME': 'cltbld', 10:34:03 INFO - 'MAIL': '/var/mail/cltbld', 10:34:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:03 INFO - 'MOZ_NO_REMOTE': '1', 10:34:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:03 INFO - 'NO_EM_RESTART': '1', 10:34:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:03 INFO - 'PWD': '/builds/slave/test', 10:34:03 INFO - 'SHELL': '/bin/bash', 10:34:03 INFO - 'SHLVL': '1', 10:34:03 INFO - 'TERM': 'linux', 10:34:03 INFO - 'TMOUT': '86400', 10:34:03 INFO - 'USER': 'cltbld', 10:34:03 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', 10:34:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:03 INFO - '_': '/tools/buildbot/bin/python'} 10:34:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:03 INFO - Downloading/unpacking blobuploader==1.2.4 10:34:03 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 10:34:03 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 10:34:03 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 10:34:03 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 10:34:03 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 10:34:03 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 10:34:05 INFO - Downloading blobuploader-1.2.4.tar.gz 10:34:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:34:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:34:05 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 10:34:05 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 10:34:05 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 10:34:05 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 10:34:05 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 10:34:05 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 10:34:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:34:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:34:05 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 10:34:05 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 10:34:05 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 10:34:05 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 10:34:05 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 10:34:05 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 10:34:06 INFO - Downloading docopt-0.6.1.tar.gz 10:34:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:34:06 INFO - Installing collected packages: blobuploader, requests, docopt 10:34:06 INFO - Running setup.py install for blobuploader 10:34:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:34:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:34:06 INFO - Running setup.py install for requests 10:34:06 INFO - Running setup.py install for docopt 10:34:06 INFO - Successfully installed blobuploader requests docopt 10:34:06 INFO - Cleaning up... 10:34:06 INFO - Return code: 0 10:34:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:06 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 0x7feb17381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4410>, '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 0x10f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f57a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', '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 10:34:06 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 10:34:06 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 10:34:06 INFO - Using env: {'DISPLAY': ':0', 10:34:06 INFO - 'HOME': '/home/cltbld', 10:34:06 INFO - 'LANG': 'en_US.UTF-8', 10:34:06 INFO - 'LANGUAGE': 'en_US:en', 10:34:06 INFO - 'LOGNAME': 'cltbld', 10:34:06 INFO - 'MAIL': '/var/mail/cltbld', 10:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:06 INFO - 'MOZ_NO_REMOTE': '1', 10:34:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:06 INFO - 'NO_EM_RESTART': '1', 10:34:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:06 INFO - 'PWD': '/builds/slave/test', 10:34:06 INFO - 'SHELL': '/bin/bash', 10:34:06 INFO - 'SHLVL': '1', 10:34:06 INFO - 'TERM': 'linux', 10:34:06 INFO - 'TMOUT': '86400', 10:34:06 INFO - 'USER': 'cltbld', 10:34:06 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', 10:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:06 INFO - '_': '/tools/buildbot/bin/python'} 10:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:34:07 INFO - Running setup.py (path:/tmp/pip-dfkigy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:34:07 INFO - Running setup.py (path:/tmp/pip-lov7mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:34:07 INFO - Running setup.py (path:/tmp/pip-pw25sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:34:07 INFO - Running setup.py (path:/tmp/pip-G2ubrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:34:07 INFO - Running setup.py (path:/tmp/pip-0n9mAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:34:07 INFO - Running setup.py (path:/tmp/pip-FT229z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:34:07 INFO - Running setup.py (path:/tmp/pip-zstMV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:34:07 INFO - Running setup.py (path:/tmp/pip-_MVsYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:34:07 INFO - Running setup.py (path:/tmp/pip-ll50h9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:34:07 INFO - Running setup.py (path:/tmp/pip-ZIPB5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:34:07 INFO - Running setup.py (path:/tmp/pip-efKXVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:34:07 INFO - Running setup.py (path:/tmp/pip-aXp6PJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:34:07 INFO - Running setup.py (path:/tmp/pip-yG8Aq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:34:08 INFO - Running setup.py (path:/tmp/pip-hK1hGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:08 INFO - Running setup.py (path:/tmp/pip-SKlsnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:34:08 INFO - Running setup.py (path:/tmp/pip-9WyGhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:34:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:34:08 INFO - Running setup.py (path:/tmp/pip-iQsG1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:34:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:34:08 INFO - Running setup.py install for manifestparser 10:34:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:34:08 INFO - Running setup.py install for mozcrash 10:34:08 INFO - Running setup.py install for mozdebug 10:34:08 INFO - Running setup.py install for mozdevice 10:34:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:34:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:34:08 INFO - Running setup.py install for mozfile 10:34:08 INFO - Running setup.py install for mozhttpd 10:34:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:34:08 INFO - Running setup.py install for mozinfo 10:34:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:34:08 INFO - Running setup.py install for mozInstall 10:34:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:34:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:34:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:34:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:34:09 INFO - Running setup.py install for mozleak 10:34:09 INFO - Running setup.py install for mozlog 10:34:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:34:09 INFO - Running setup.py install for moznetwork 10:34:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:34:09 INFO - Running setup.py install for mozprocess 10:34:09 INFO - Running setup.py install for mozprofile 10:34:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:34:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:34:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:34:09 INFO - Running setup.py install for mozrunner 10:34:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:34:09 INFO - Running setup.py install for mozscreenshot 10:34:09 INFO - Running setup.py install for moztest 10:34:09 INFO - Running setup.py install for mozversion 10:34:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:34:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:34:10 INFO - Cleaning up... 10:34:10 INFO - Return code: 0 10:34:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:10 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 0x7feb17381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4410>, '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 0x10f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f57a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', '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 10:34:10 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 10:34:10 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 10:34:10 INFO - Using env: {'DISPLAY': ':0', 10:34:10 INFO - 'HOME': '/home/cltbld', 10:34:10 INFO - 'LANG': 'en_US.UTF-8', 10:34:10 INFO - 'LANGUAGE': 'en_US:en', 10:34:10 INFO - 'LOGNAME': 'cltbld', 10:34:10 INFO - 'MAIL': '/var/mail/cltbld', 10:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:10 INFO - 'MOZ_NO_REMOTE': '1', 10:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:10 INFO - 'NO_EM_RESTART': '1', 10:34:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:10 INFO - 'PWD': '/builds/slave/test', 10:34:10 INFO - 'SHELL': '/bin/bash', 10:34:10 INFO - 'SHLVL': '1', 10:34:10 INFO - 'TERM': 'linux', 10:34:10 INFO - 'TMOUT': '86400', 10:34:10 INFO - 'USER': 'cltbld', 10:34:10 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', 10:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:10 INFO - '_': '/tools/buildbot/bin/python'} 10:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:34:10 INFO - Running setup.py (path:/tmp/pip-2k49pO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:34:10 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)) 10:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:34:10 INFO - Running setup.py (path:/tmp/pip-4Slgbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:34:10 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)) 10:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:34:10 INFO - Running setup.py (path:/tmp/pip-AYQHJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:34:10 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)) 10:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:34:10 INFO - Running setup.py (path:/tmp/pip-SNa5QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:34:10 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)) 10:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:34:10 INFO - Running setup.py (path:/tmp/pip-lI3s6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:34:10 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)) 10:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:34:10 INFO - Running setup.py (path:/tmp/pip-O5SDbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:34:10 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)) 10:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:34:10 INFO - Running setup.py (path:/tmp/pip-CMXES0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:34:10 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)) 10:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:34:10 INFO - Running setup.py (path:/tmp/pip-84rRcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:34:10 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)) 10:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:34:10 INFO - Running setup.py (path:/tmp/pip-G4AtGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:34:10 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)) 10:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:34:10 INFO - Running setup.py (path:/tmp/pip-562U9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:34:10 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)) 10:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:34:10 INFO - Running setup.py (path:/tmp/pip-mHpcp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:34:11 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)) 10:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:34:11 INFO - Running setup.py (path:/tmp/pip-xpdsz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:34:11 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)) 10:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:34:11 INFO - Running setup.py (path:/tmp/pip-_zK277-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:34:11 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)) 10:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:34:11 INFO - Running setup.py (path:/tmp/pip-m5H0UV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:34:11 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)) 10:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:11 INFO - Running setup.py (path:/tmp/pip-kZDtUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:11 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)) 10:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:34:11 INFO - Running setup.py (path:/tmp/pip-e07N9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:34:11 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)) 10:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:34:11 INFO - Running setup.py (path:/tmp/pip-2WkcN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:34:11 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)) 10:34:11 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)) 10:34:11 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)) 10:34:11 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)) 10:34:11 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)) 10:34:11 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)) 10:34:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:13 INFO - Downloading blessings-1.6.tar.gz 10:34:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:34:13 INFO - Installing collected packages: blessings 10:34:13 INFO - Running setup.py install for blessings 10:34:13 INFO - Successfully installed blessings 10:34:13 INFO - Cleaning up... 10:34:13 INFO - Return code: 0 10:34:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:34:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:34:13 INFO - Reading from file tmpfile_stdout 10:34:13 INFO - Current package versions: 10:34:13 INFO - argparse == 1.2.1 10:34:13 INFO - blessings == 1.6 10:34:13 INFO - blobuploader == 1.2.4 10:34:13 INFO - docopt == 0.6.1 10:34:13 INFO - manifestparser == 1.1 10:34:13 INFO - mozInstall == 1.12 10:34:13 INFO - mozcrash == 0.17 10:34:13 INFO - mozdebug == 0.1 10:34:13 INFO - mozdevice == 0.48 10:34:13 INFO - mozfile == 1.2 10:34:13 INFO - mozhttpd == 0.7 10:34:13 INFO - mozinfo == 0.9 10:34:13 INFO - mozleak == 0.1 10:34:13 INFO - mozlog == 3.1 10:34:13 INFO - moznetwork == 0.27 10:34:13 INFO - mozprocess == 0.22 10:34:13 INFO - mozprofile == 0.28 10:34:13 INFO - mozrunner == 6.11 10:34:13 INFO - mozscreenshot == 0.1 10:34:13 INFO - mozsystemmonitor == 0.0 10:34:13 INFO - moztest == 0.7 10:34:13 INFO - mozversion == 1.4 10:34:13 INFO - psutil == 3.1.1 10:34:13 INFO - requests == 1.2.3 10:34:13 INFO - wsgiref == 0.1.2 10:34:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:13 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 0x7feb17381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4410>, '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 0x10f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f57a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', '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 10:34:13 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 10:34:13 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 10:34:13 INFO - Using env: {'DISPLAY': ':0', 10:34:13 INFO - 'HOME': '/home/cltbld', 10:34:13 INFO - 'LANG': 'en_US.UTF-8', 10:34:13 INFO - 'LANGUAGE': 'en_US:en', 10:34:13 INFO - 'LOGNAME': 'cltbld', 10:34:13 INFO - 'MAIL': '/var/mail/cltbld', 10:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:13 INFO - 'MOZ_NO_REMOTE': '1', 10:34:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:13 INFO - 'NO_EM_RESTART': '1', 10:34:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:13 INFO - 'PWD': '/builds/slave/test', 10:34:13 INFO - 'SHELL': '/bin/bash', 10:34:13 INFO - 'SHLVL': '1', 10:34:13 INFO - 'TERM': 'linux', 10:34:13 INFO - 'TMOUT': '86400', 10:34:13 INFO - 'USER': 'cltbld', 10:34:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', 10:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:13 INFO - '_': '/tools/buildbot/bin/python'} 10:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:14 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)) 10:34:14 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)) 10:34:14 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)) 10:34:14 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)) 10:34:14 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)) 10:34:14 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)) 10:34:14 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)) 10:34:14 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)) 10:34:14 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)) 10:34:14 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)) 10:34:14 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)) 10:34:14 INFO - Cleaning up... 10:34:14 INFO - Return code: 0 10:34:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:14 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 0x7feb17381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4410>, '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 0x10f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f57a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', '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 10:34:14 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 10:34:14 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 10:34:14 INFO - Using env: {'DISPLAY': ':0', 10:34:14 INFO - 'HOME': '/home/cltbld', 10:34:14 INFO - 'LANG': 'en_US.UTF-8', 10:34:14 INFO - 'LANGUAGE': 'en_US:en', 10:34:14 INFO - 'LOGNAME': 'cltbld', 10:34:14 INFO - 'MAIL': '/var/mail/cltbld', 10:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:14 INFO - 'MOZ_NO_REMOTE': '1', 10:34:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:14 INFO - 'NO_EM_RESTART': '1', 10:34:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:14 INFO - 'PWD': '/builds/slave/test', 10:34:14 INFO - 'SHELL': '/bin/bash', 10:34:14 INFO - 'SHLVL': '1', 10:34:14 INFO - 'TERM': 'linux', 10:34:14 INFO - 'TMOUT': '86400', 10:34:14 INFO - 'USER': 'cltbld', 10:34:14 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', 10:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:14 INFO - '_': '/tools/buildbot/bin/python'} 10:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:14 INFO - Downloading/unpacking jsonschema 10:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:34:16 INFO - Downloading/unpacking functools32 (from jsonschema) 10:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:16 INFO - Downloading functools32-3.2.3-2.tar.gz 10:34:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:34:16 INFO - warning: no files found matching '*.txt' 10:34:16 INFO - no previously-included directories found matching 'build' 10:34:16 INFO - no previously-included directories found matching 'dist' 10:34:16 INFO - no previously-included directories found matching '.git*' 10:34:16 INFO - Installing collected packages: jsonschema, functools32 10:34:16 INFO - Running setup.py install for functools32 10:34:16 INFO - warning: no files found matching '*.txt' 10:34:16 INFO - no previously-included directories found matching 'build' 10:34:16 INFO - no previously-included directories found matching 'dist' 10:34:16 INFO - no previously-included directories found matching '.git*' 10:34:16 INFO - Successfully installed jsonschema functools32 10:34:16 INFO - Cleaning up... 10:34:16 INFO - Return code: 0 10:34:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb17381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4410>, '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 0x10f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f57a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', '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 10:34:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:34:16 INFO - Using env: {'DISPLAY': ':0', 10:34:16 INFO - 'HOME': '/home/cltbld', 10:34:16 INFO - 'LANG': 'en_US.UTF-8', 10:34:16 INFO - 'LANGUAGE': 'en_US:en', 10:34:16 INFO - 'LOGNAME': 'cltbld', 10:34:16 INFO - 'MAIL': '/var/mail/cltbld', 10:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:16 INFO - 'MOZ_NO_REMOTE': '1', 10:34:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:16 INFO - 'NO_EM_RESTART': '1', 10:34:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:16 INFO - 'PWD': '/builds/slave/test', 10:34:16 INFO - 'SHELL': '/bin/bash', 10:34:16 INFO - 'SHLVL': '1', 10:34:16 INFO - 'TERM': 'linux', 10:34:16 INFO - 'TMOUT': '86400', 10:34:16 INFO - 'USER': 'cltbld', 10:34:16 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', 10:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:16 INFO - '_': '/tools/buildbot/bin/python'} 10:34:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:17 INFO - Downloading/unpacking flake8 10:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:34:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:34:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:34:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:34:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:34:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:34:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:34:19 INFO - no previously-included directories found matching 'docs/_build' 10:34:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:34:19 INFO - Running setup.py install for pep8 10:34:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:34:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:34:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:34:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:34:19 INFO - no previously-included directories found matching 'docs/_build' 10:34:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:34:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:34:19 INFO - Cleaning up... 10:34:19 INFO - Return code: 0 10:34:19 INFO - Running post-action listener: _resource_record_post_action 10:34:19 INFO - Running post-action listener: _start_resource_monitoring 10:34:19 INFO - Starting resource monitoring. 10:34:19 INFO - ##### 10:34:19 INFO - ##### Running install step. 10:34:19 INFO - ##### 10:34:19 INFO - Running pre-action listener: _resource_record_pre_action 10:34:19 INFO - Running main action method: install 10:34:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:34:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:34:20 INFO - Reading from file tmpfile_stdout 10:34:20 INFO - Detecting whether we're running mozinstall >=1.0... 10:34:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:34:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:34:20 INFO - Reading from file tmpfile_stdout 10:34:20 INFO - Output received: 10:34:20 INFO - Usage: mozinstall [options] installer 10:34:20 INFO - Options: 10:34:20 INFO - -h, --help show this help message and exit 10:34:20 INFO - -d DEST, --destination=DEST 10:34:20 INFO - Directory to install application into. [default: 10:34:20 INFO - "/builds/slave/test"] 10:34:20 INFO - --app=APP Application being installed. [default: firefox] 10:34:20 INFO - mkdir: /builds/slave/test/build/application 10:34:20 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'] 10:34:20 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 10:34:35 INFO - Reading from file tmpfile_stdout 10:34:35 INFO - Output received: 10:34:35 INFO - /builds/slave/test/build/application/firefox/firefox 10:34:35 INFO - Running post-action listener: _resource_record_post_action 10:34:35 INFO - ##### 10:34:35 INFO - ##### Running run-tests step. 10:34:35 INFO - ##### 10:34:35 INFO - Running pre-action listener: _resource_record_pre_action 10:34:35 INFO - Running main action method: run_tests 10:34:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:34:35 INFO - Python 2.7.3 10:34:35 INFO - Return code: 0 10:34:35 INFO - grabbing minidump binary from tooltool 10:34: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')]} 10:34:35 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 0x10f4410>, '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 0x10f5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f57a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:34:35 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 10:34:35 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 10:34:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:34:36 INFO - Return code: 0 10:34:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:34:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:34:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:34:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:34:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:34:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:34:36 INFO - Return code: 0 10:34:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:34:36 INFO - Using env: {'DISPLAY': ':0', 10:34:36 INFO - 'HOME': '/home/cltbld', 10:34:36 INFO - 'LANG': 'en_US.UTF-8', 10:34:36 INFO - 'LANGUAGE': 'en_US:en', 10:34:36 INFO - 'LOGNAME': 'cltbld', 10:34:36 INFO - 'MAIL': '/var/mail/cltbld', 10:34:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:34:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:36 INFO - 'MOZ_NO_REMOTE': '1', 10:34:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:34:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:36 INFO - 'NO_EM_RESTART': '1', 10:34:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:36 INFO - 'PWD': '/builds/slave/test', 10:34:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:34:36 INFO - 'SHELL': '/bin/bash', 10:34:36 INFO - 'SHLVL': '1', 10:34:36 INFO - 'TERM': 'linux', 10:34:36 INFO - 'TMOUT': '86400', 10:34:36 INFO - 'USER': 'cltbld', 10:34:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323', 10:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:36 INFO - '_': '/tools/buildbot/bin/python'} 10:34:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:34:37 INFO - mozversion application_buildid: 20160530075343 10:34:37 INFO - mozversion application_changeset: de472f31c8a3f1711bdf65beecc8dfa983950b64 10:34:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:34:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:34:37 INFO - mozversion application_name: Firefox 10:34:37 INFO - mozversion application_remotingname: firefox-dev 10:34:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:34:37 INFO - mozversion application_vendor: Mozilla 10:34:37 INFO - mozversion application_version: 48.0a2 10:34:37 INFO - mozversion platform_buildid: 20160530075343 10:34:37 INFO - mozversion platform_changeset: de472f31c8a3f1711bdf65beecc8dfa983950b64 10:34:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:34:37 INFO - mozversion platform_version: 48.0a2 10:34:37 INFO - using testdate: 1464629677 10:34:37 INFO - actual date: 1464629677 10:34:37 INFO - starting webserver on 'localhost:50940' 10:34:37 INFO - SUITE-START | Running 2 tests 10:34:37 INFO - TEST-START | dromaeo_css 10:34:37 INFO - operating with platform_type : linux_ 10:34:37 INFO - Initialising browser for dromaeo_css test... 10:34:37 INFO - TEST-INFO | started process 3672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn0POHg/profile http://localhost:50940/getInfo.html) 10:34:40 INFO - PROCESS | 3672 | 10:34:40 INFO - PROCESS | 3672 | (process:3750): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:34:41 INFO - PROCESS | 3672 | __metrics Screen width/height:1600/1200 10:34:41 INFO - PROCESS | 3672 | colorDepth:24 10:34:41 INFO - PROCESS | 3672 | Browser inner width/height: 1024/697 10:34:41 INFO - PROCESS | 3672 | __metrics 10:34:42 ERROR - PROCESS | 3672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 10:34:42 INFO - TEST-INFO | 3672: exit 0 10:34:42 INFO - Browser initialized. 10:34:42 INFO - Running cycle 1/1 for dromaeo_css test... 10:34:42 INFO - TEST-INFO | started process 3801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn0POHg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:34:44 INFO - PROCESS | 3801 | 10:34:44 INFO - PROCESS | 3801 | (process:3874): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:34:54 INFO - PROCESS | 3801 | RSS: Main: 151887872 10:34:54 INFO - PROCESS | 3801 | 10:35:44 INFO - PROCESS | 3801 | 1464629744415 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] 10:37:51 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:50940/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50940/tests/dromaeo/cssquery-ext.html) 10:37:52 INFO - PROCESS | 3801 | RSS: Main: 156553216 10:37:52 INFO - PROCESS | 3801 | 10:40:54 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:50940/tests/dromaeo/cssquery-ext.html (next: http://localhost:50940/tests/dromaeo/cssquery-jquery.html) 10:40:55 INFO - PROCESS | 3801 | RSS: Main: 153489408 10:40:55 INFO - PROCESS | 3801 | 10:43:56 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:50940/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50940/tests/dromaeo/cssquery-mootools.html) 10:43:57 INFO - PROCESS | 3801 | RSS: Main: 152666112 10:43:57 INFO - PROCESS | 3801 | 10:46:59 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:50940/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50940/tests/dromaeo/cssquery-prototype.html) 10:46:59 INFO - PROCESS | 3801 | RSS: Main: 153018368 10:46:59 INFO - PROCESS | 3801 | 10:50:02 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:50940/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50940/tests/dromaeo/cssquery-yui.html) 10:50:02 INFO - PROCESS | 3801 | RSS: Main: 154406912 10:50:02 INFO - PROCESS | 3801 | 10:53:04 INFO - PROCESS | 3801 | Cycle 1(1): loaded http://localhost:50940/tests/dromaeo/cssquery-yui.html (next: http://localhost:50940/tests/dromaeo/cssquery-dojo.html) 10:53:05 INFO - PROCESS | 3801 | RSS: Main: 156131328 10:53:05 INFO - PROCESS | 3801 | 10:53:05 INFO - PROCESS | 3801 | __start_tp_report 10:53:05 INFO - PROCESS | 3801 | _x_x_mozilla_page_load 10:53:05 INFO - PROCESS | 3801 | _x_x_mozilla_page_load_details 10:53:05 INFO - PROCESS | 3801 | |i|pagename|runs| 10:53:05 INFO - PROCESS | 3801 | |0;dojo.html;3326.9667303326964;3388.068281222664;3395.830208489575;3406.5571475708152;3429.245565975486;5620.606557540974;5653.943460565393;5695.088785794269;5705.74324155413;5716.114002329635;5591.608587398873;5650.6892120933435;5673.092305231164;5684.317881854173;5701.258836351279;5147.0477961577135;5186.948130518685;5188.0920838853235;5257.421683614818;5294.497022782849;5125.103106956286;5223.738813059351;5296.576273898079;5329;5337.919931201035;5113.488651134875;5119.308893299412;5150.227465880129;5195.454477279888;5238.00477909198;5147.871303217431;5186.1442861927735;5198.428172900978;5208.453112423179;5211.7133557654315;5093.694378337274;5114;5152.793888244466;5205.427402985669;5246.31797866275;5490.231367608538;5506.752196151183;5544;5548.667079975215;5590.692511911843;5963.880722385528;5973.970130149365;5974.133750606138;5982.491488223506;5991.520678345765;6034.6982650867285;6060.181875446802;6067.302260240085;6081.239845019372;6083.574149809515;5587.832365029056;5655.208270842086;5706.400827913051;5724.856878577985;5766.567507436917;6149.292831324455;6162.630242185483;6206.968965155235;6209.441150296495;6232.0963460298;5973.671448070311;5984.461398474158;5992.460678538865;5993.041113421831;6011.248593925759;6054.334023257438;6074.848128796815;6090.299615544269;6093.207882975274;6134.04922237054;6054.152418661391;6065.302490213594;6077.6961151943115;6092.1775560299675;6101.328853826076;5972.074328479092;5977.850553736192;6005.3694362091355;6016.578839481194;6095.847603809941;4505.279155335131;4506.729596224237;4521.547845215518;4522.208613492626;4549.40857688505;4073.450084238649;4085;4087.8978025549004;4094.140230551558;4129.132882094794;5702.401247868997;5781.855453613609;5867.471927526458;5890.705464726747;5919.023361145449;6024.728887200086;6060.272767267956;6093.39066093396;6114.145302971568;6136.7948077883175;5869.4717475427415;5891.410858914074;5892.587518873724;5895;5907.2911250650195;5109.335786347825;5184.948150518522;5221.817236396708;5268.868278293074;5272.657277276965;6329.303776584572;6340.302566717657;6360.968195158995;6378.107065010902;6390.105385246069;6187.535934804818;6188.381161883955;6196.1635179250225;6196.411340922605;6214.161088253028;6153.4154255345675;6323.9683801580695;6347.841303967438;6350.682465876595;6422.165118534561;5987.88024239504;6017.217761690952;6019.154580562689;6044.7279872406725;6062.878742425215;6076.1493390924425;6128.662923539248;6139.72371243304;6141.170941922784;6147.385261473817;5792.681402522901;5902.498287645598;5945.435183657545;5958.493528050164;5998.580099393001;5846;5849.64902105875;5854.092615644582;5884.264466941632;5899.380565040609;5725.19847221381;5752.769889204553;5812.622179558315;5835.533157347317;5839.153322768259;5918.201042859159;5999.370066142992;6026.698665066817;6030.819075427744;6033.095035744674;5826.329972053099;5860.09168578871;5864.618799778001;5882.794102206402;5896.086106653475 10:53:05 INFO - PROCESS | 3801 | |1;ext.html;660.9933900660993;671.6339594920768;691.3777600159858;711.5623891306844;779.0184367696701;39251.214975700466;40107.59892401075;40394.394084088686;40581.188376232494;40852.182956340854;39825.80087099568;40575.59424405755;40600.79699601498;40772.18455630886;40819.59180408195;8369.665213391458;8575.914240857604;8633.3524985626;8635.093315201877;8644.697435589756;8400.369972252074;8502;8510.319174466058;8512.191341822549;8514.787130321729;8540.402171847942;8557.358198135134;8595.742127736146;8602.2688071514;8611.698590549331;8762.036176020632;8825.470471771681;8828.955855220747;8830.779230519223;8854.86717699235;8548.57257137147;8602.956985215034;8658.04761476237;8662.047174810767;8671.523066231355;35192.824035879916;35699.28601427983;35745;35801.46297805535;35831.64168358309;3594.26317604893;3741.1395379062697;3756.323861704892;3785.886423407302;3804.7907365094907;32657.836710816533;33013.66986330154;33116;33512;33533.664663353295;3968.0873399118364;3978.6021397860272;4018.598140185958;4031.072853243741;4034.677225821927;315026.99999999773;315368;315409;315427;315633;59493.70253148793;59959;60148;60262;60272;69270.30729692739;70615.2938470619;70774;71119.6444017787;71203.6439817808;16655.25051372691;16788.160591970354;16819.57951051209;16871.156442177842;16878.493645190665;11044.779104417867;11130;11140.33158010522;11168.66494005181;11173.776524469466;19404.514887127934;19967.500812479804;20017.799822001885;20030;20653;7438;7489.213632568611;7551.773446796605;7630.084389873251;7639.465237433437;1102.5038732570376;1157.8610566732045;1175.905927525796;1186.602488166474;1194.3431112887877;32221.51667724986;32637.18407039843;32828.1792955178;33097.338053239284;33328.50007249893;1211;1224.2593231095236;1240.342618412243;1247.114548670436;1325.1121748428577;15809.68380632404;15887.205639717968;15940.442084526985;16017.359305627644;16244.350225990827;440461;474323;482686;484643;496275;45950.54049459463;46515;46539.76730116328;46758.5324146761;46844;1461.926903654813;1467.207707837777;1469.7060587882465;1499.392745937897;1519.8480151984934;27581.31046723848;28428.57357139603;28567.14298570963;29073.85463072671;29136;52350.21474677807;52812.735936320074;53097.20354194613;53503.46496534985;53721.19418208808;430566;436325;436535;437394;438255;30813.22966925845;31039.689603104584;31567.84216078905;31581.368372631958;31659.52510712295;39294;39496;39667;40389.59610403858;40501.594984050964;40423.7978810104;40849.18301633891;41477.578878044944;41792;42015.579844201166;40010.79994600009;40233.1953360937;40788.38817417682;41535.37696934488;41631;42541.57458425376;42626;43645.78177109221;44403.77798111118;44447.33329000003;29447.411051779272;30937;30997.225069373446;31001;31074.68925310718;25908.481830363664;25918.35204119912;26097.347566310993;26259.4748105033;26379.86810066014 10:53:05 INFO - PROCESS | 3801 | |2;jquery.html;431.0559377208787;434.30294377524075;435.19271750902055;442.1356248534116;444.03201021772526;17099.40152094677;17806.732899006493;17905;17907.641847163064;18361;16924.069176195306;16999.065051422167;17199.226034828433;17389.13054347284;17427.73858392125;5769.278840144982;5815.534757219423;6049.6672683002635;6053.848653783669;6057.575969682124;5939.970300148493;6059.787907423241;6062.18160548327;6062.969295219823;6095.969520152393;5694.601377903548;5997.340292567814;6020.849478763044;6029.939700602981;6032.426919442668;5813.331466881321;5844.503217226498;5872.236609240814;5886.941130588682;5887.676177810219;5215.843524694265;5263.789448422059;5276.076686579871;5284;5284.841454756363;23179.420514487105;23899.88050059756;23922.282331529907;24022.7597724024;24051.7594824053;2511.1085564624477;2511.748825117492;2567.7560631739957;2580.5742052561304;2629.18495266468;14824.184669843155;14921.328540215607;14994.47519336829;15096.54710358691;15154.621134471616;2024.8481363897768;2030.644637188486;2082.6980087887323;2092.780258072896;2102.7161333219974;74747;76025.61987190084;77274.61362693207;77399.99999999943;78173.21826781717;11043.282186657842;11238.21332506733;11290.774184516427;11328.490217940212;11532.711682208012;15975.201239937956;16074.115923624078;16185.83814161867;16192.271347789378;16279.755803662954;8751.912480875237;8796.47221166732;8857.335699822539;8964.68623598171;9056.50189239585;8829.16122968317;8832.072632373509;8842.425242359226;8881.333899957399;8964.68623598171;7073.434125269966;7077.292270772881;7081.92918070823;7101.396381307647;7249.6950548901705;2024.200440825895;2025.8885761282977;2044.2845004248395;2067.5809303115393;2147.6563749799957;1063.1335461598926;1102.7077824376547;1140.9389267980857;1150.1833698074295;1218.5125949620224;17928.55178620519;19529.21883124659;19629.411117666492;19656.918869462315;20730.792692073188;1103.9944800276107;1109.1348747976592;1141.1156353825686;1154.717094311899;1192.8330033795276;11445.198836081561;11525.76948461026;11531.263568174052;11598.246114002563;11605.76788464226;463639;470270;474397;476733;486957;61453.38546614566;70388.64805675938;72570.63714681393;79369;82882;1112.5160555158532;1123.719070232442;1133.206755271297;1139.3619573039125;1144.3648774929993;18131.54671133232;18347.357842475983;18546.44360669182;18597.628047438706;18829.623407532046;36689.633103668624;36946;37898.62101379061;38543.22913541769;38679.61320386873;51178;51367.74316128396;51615.225771612706;51646.48353516417;52531.47468525419;8752.431091979;8990.86513702282;9000.819983600422;9072.255532867843;9193.86209206849;9741.610335586498;13456.25990570528;13885.375158118111;14075.366608502438;14076.085054471836;11449.08407327395;11922.821157682469;11956.521739130338;12068.698282542655;12162.452689629165;11674.94162529182;12170.330631815335;12239.69400764988;12255.264684118982;12372.81440778407;12410.689732756753;12851.16467429614;12920.095593308753;13003.674908127372;13046.347682615642;8606.526641034803;8872.157145071207;8878.289736820909;9017.819643607223;9128.315376346667;12017.519299227934;12072.094592905392;12126.393680315772;12199.939000304941;12210.572629958264 10:53:05 INFO - PROCESS | 3801 | |3;mootools.html;1463.7511623024088;1537.1699282387508;1682.5434865096959;1823.8358547730709;1887.1885089411549;7609.8478030439355;8101.918980810205;8446.535440550775;8656.52389118599;8670.609822557984;8535.957320213405;8537.4450660707;8599.699010534632;8613.655453781857;8621.310295176387;2420.298113547069;2432.221689059502;2443.4990826880535;2453.129139155601;2457.9016839326405;2302.8370672810206;2340.8361414700976;2344.8006919411787;2345.1909091363455;2402.627592723122;2326.8022218111482;2328.4877326988035;2345.7067866516686;2431;2443.853368797869;2423.5758742220128;2427.963580546293;2429.4776623026046;2433.586290330648;2495.9750402495924;2400.543896659629;2411.3007227903886;2425.333033415807;2425.466397392571;2435.975640243593;8816.603252853636;8827.293816494664;8836;8868.15752503511;8874.378793484459;5352.2239275305255;5405.594580406485;5462;5489.258950041733;5491.478309560625;3484.686378225972;3542.079059444537;3546.716262698978;3558.5373901392913;3621.5654121505327;1134.2513940799115;1135.188340336655;1141.2296699727733;1146.0373286439349;1149.494222542087;12411.75176496474;12473.189242699285;12518.374081295899;12525.686857828536;12566.05754568402;4655.86032419028;4729.4797572267025;4801.327814106028;4803.423589169322;4805.111054454867;10627.202959778047;10648.680539583826;10655;10676.359418434919;10686.091682206945;5448.673079615236;5462.317210348707;5470.753816078286;5476.863078423071;5497.367802702661;4373.737575745402;4812.181929072066;4826.975865120652;4949.628777841676;5008.023435430129;4013.337799263147;4094.6724262058965;4133.855315063958;4165.687573432005;4185.309423945015;1399.4472183487464;1411.4213172599184;1431.7422863884601;1442.5888621742754;1450.52132796177;1010.5654568535454;1022.8721409823772;1029.3463650581934;1032.736652153696;1033.9896601034043;5909.704514774244;6091.51267898567;6165.722542485599;6177.6911154443;6297.842553936097;1025.7743296474764;1035.6427032673716;1043.3739756146404;1045.7699306152633;1053.3100818963592;4293.656507479394;4320.1143765527995;4333.025069359432;4338.609525142752;4352.194843953878;10657.147428205724;11019.559217631366;11087.556497740161;11093.500792464198;11125.554977800959;10018.64934727281;10355.844662330072;11003.17476189289;11058.502367393487;11131.443427828575;7882.684692612232;7891.802704932423;7896.60516974149;7899.486533375312;7957.880631790527;5885.440883116097;6096.481799047131;6108.664023478751;6137.693115344304;6153.230846144232;9039;9065.27477801761;9101.954490227772;9108.499032553273;9134.269258459175;9112.498812565373;9309.86035209486;9555.61777528891;9572.042795720372;9584.616615335308;6550.967245163934;7056.894146587702;7177.569345839266;7262.055932728923;7287.161976372785;8025;8054.3556515479795;8068.798280043045;8090.312323452337;8111.310538604049;7066.893996590158;7390.926090739239;7518.699252029857;7607.049118860143;7677.347425468898;7093.787186384417;7156.928430715626;7214.74748383804;7312.81717957034;7347;7224;7273.927260727537;7315.524490908074;7362.815929601803;7370.815729606803;5099.770510327118;5224.242484839753;5275.419703832498;5412.404635490172;5433.185022246695;5148.922766158586;5197.298364720866;5261.552768014762;5271.762770675252;5343.038253114477 10:53:05 INFO - PROCESS | 3801 | |4;prototype.html;349.9912502187445;350.34835206515874;360.1015466411304;360.56731921693955;366.7121309771828;6626.105475760771;6638.668066596669;6746.76386326478;6750.088738020366;6811.659417029141;6613.470922326214;6614.3716346947085;6644.468442524599;6648.135742353499;6687.632180230085;4791.928121078178;4892.070506603752;4984.576311013569;5027.924581131286;5029.2456131580375;5009.073321435546;5010.799568017275;5012.223105418648;5034.169362055257;5050.646454748169;4981.676191047571;4982.427020892607;4982.5017498250245;5005.1491246488185;5014.674046187004;5021.723805190713;5034.11902916988;5034.521720436571;5037.269595908591;5048.368953880765;4370.235208838472;4380.802863871133;4382.167388196232;4386.583274588909;4394.209042372372;6128.938710612882;6340.334264902165;6350.174477317965;6409.583377080521;6419.293877673452;5674.744636491327;5688.857778555528;5693.459121383462;5696.658200507983;5721.6853073080965;7078.044463997346;7084.92915070853;7085.504014718972;7089.71641134354;7092.042574252461;4686.08621318843;4693.225617773098;4694.765261736899;4698.318743782167;4732.432108147044;7192.208857025776;7306.050213472267;7308.524945878554;7359.8160045999275;7362.77911662651;4870.342503761947;4884.4871288514905;4888.902221955612;4900.240462728283;4900.240462728283;4907.779149938261;4940.1601727706375;4951.678140920829;4954.405471343462;4954.554090131834;5754.05058165398;5758.107493338539;5771.249737534177;5773.855653608609;5774.971125144348;7024.262452442522;7066.50534462593;7073.115860517435;7078.1860086090755;7083.220845706968;1685.8988460692399;1714.1086634950007;1715.3996101364423;1716.2705850013945;1717.3559915031863;1096.8080585897435;1110.8666959964855;1150.9539618415338;1150.9769804603861;1154.3766366162179;6715;6728.226253980855;6752.966235168891;6771.661416929134;6783.525153239325;7213.603251821095;7280.745173918887;7298.52559583636;7332.450066245053;7391.113066431955;6872.10662613857;6886.10480637524;6887.896681549781;6917.7232910684015;6943.861122777516;3963.524377074712;3992.401139828991;3999.1801680655394;4010.4184893190322;4026.2350153471334;7710.537367757953;7710.614469276514;7726.266004729542;7772.961135194288;7809.882851757228;7398.075240594926;7522.398208143335;7564.281393267631;7569.659365328574;7590.81022974419;7613.124490683532;7646.3882889368715;7667.616619169019;7676.2707542784465;7684.231576842383;7302.0142280791415;7383.520071195355;7385.076865391826;7393.8890916637365;7396.852062958818;7228.63856807147;7255.52839065459;7291.125064992235;7298.671559779928;7307.926920730937;7466.552006879605;7655.196204398458;7679.923200767921;7682.231776822273;7701.691932322644;4894.4616092230535;4910.5580497753945;4924.50754924519;4933.679310844784;4940.431850337257;7359.668814903235;7404.148522919718;7422.294881986203;7430.96284518574;7438.144613369532;7121.537100088478;7145.571265724073;7161.892571611325;7167.605781682058;7202.819929501804;7017.789466316019;7159.8568028640175;7162.06893103914;7162.247963963709;7176.928230717626;6969.895451568332;6975.267596902455;6992.405645520188;6993.895091573529;7034.964825175842;7174.497785154989;7177.820554485971;7239.095113110861;7254;7260.636968151465;6854.828629284308;7006.948957656392;7026.648667566704;7038.577685338896;7066.681999310146 10:53:05 INFO - PROCESS | 3801 | |5;yui.html;905.9229965452936;909.7043460875213;933.7058826469662;937.7139972308445;950.9096635819596;14946;14952.77570836437;15244;15521.22393880307;15627.140507272095;14623.561293161196;14680.779788303184;14688.779668304984;14712.485063022796;14747;872.8428882801124;891.5898686604154;907.4736652741427;909.5179554835914;910.713125365511;925.296774451415;927.1562877781221;927.2767241551601;927.5455027036737;928.0626567167142;948.6252930092609;951.1914872358475;951.4529145741227;951.4957072751453;953.3421938862198;942.8821397325335;948.928830337724;949.264320151881;949.4113649537262;950.1828427552299;691.9515633905629;692.6813665713778;697.4106879686657;697.9685914133876;698.3714656808862;14756.114633122046;14788.778168327484;14885.330160142712;14924.328405221791;14957.850421495863;14655;14668.413263469449;14701.411943522353;14745.483908063274;14774.852251477563;12037.638870833889;12037.939810300892;12102.81845772314;12138.939305303416;12305.26168429897;3976.5824588418377;4006.7395619284653;4036.1120553478186;4045.656119229869;4061.289274376972;54188.45811541873;54491.18263226015;55014.449855501734;55245;55861;10804.891951080546;10959.123270138529;11066.944665276784;11135.387553684463;11365.147613928988;19553.60892782165;19850.305239316556;19918;19937.202511899362;19976.90011549933;8259.793505162299;8288.129746376664;8328.875066874001;8372.623231954576;8760.956195218983;4269.743815371025;4422.137683151755;4437.33439984005;4559.4072770539615;4583.977080114578;3647.6899463545897;3688.6680198782237;3694.3904255797493;3695.870644527429;3702.851885924587;674.1193757197852;676.9356911093438;701.9227884932653;703.2405002597183;704.225352112672;639.8688268904864;756.3911051603512;788.3259812860036;797.3820289275858;817.2154731457748;9301.488418137067;9328;9482.620695172116;9692.70921872345;9725.0761177688;637.8437282865635;788.5662885413;792.8691765858684;792.9563873986987;793.3811626931004;4243.342281946303;4481.619062379669;4488.102379524108;4513.435820522434;4574.130915126116;60505.69747151236;61241.693791531645;61419.38580614226;61929.38070619236;62267.37732622616;53068.73465632647;54771;55135.44864551383;55308.72345638246;56069.719651402294;49252.50747492551;49330.50669493331;49363.25955110676;50165.498345016815;50255.999999999265;8658.264047556027;8739.169778870997;8980.012198658273;9019.909800901907;9078.909210907806;37316;37904;38104.80947595244;38372.040698982746;38665.42001869918;43683.56316436922;43717.12565748731;46290.30564541467;48319.27521087257;49146.50853491562;10856.565737370416;11141.944290278821;11372.203945724052;11400.201985860911;11422.143339249757;12242.632721018384;12313.630591082281;12508;12754.29851358147;13091.476340946256;11926.701832454259;11929.701757456132;12013.399330033639;12212.633620991384;12304.569340073054;11792.351420671603;11875.287482751062;11956;12000.1599888007;12057.336846473178;11577.768444631229;11981.400929953641;12891.548795792101;13203.537876174289;13315.06794524374;9500.097490738368;9579.568919398504;11027.117830573696;11095.22333436684;11339.169231075604;11043.738217343101;11070.557177713123;11171.273867198606;11342;11510.654680359603 10:53:05 INFO - PROCESS | 3801 | __end_tp_report 10:53:05 INFO - PROCESS | 3801 | __start_cc_report 10:53:05 INFO - PROCESS | 3801 | _x_x_mozilla_cycle_collect,324 10:53:05 INFO - PROCESS | 3801 | __end_cc_report 10:53:05 INFO - PROCESS | 3801 | __startTimestamp1464630785007__endTimestamp 10:53:05 INFO - PROCESS | 3801 | 10:53:05 INFO - PROCESS | 3801 | ------- Summary: start ------- 10:53:05 INFO - PROCESS | 3801 | Number of tests: 6 10:53:05 INFO - PROCESS | 3801 | 10:53:05 INFO - PROCESS | 3801 | [#0] dojo.html Cycles:165 Average:5650.42 Median:5884.26 stddev:641.78 (10.9%) stddev-sans-first:617.32 10:53:05 INFO - PROCESS | 3801 | Values: 3327.0 3388.1 3395.8 3406.6 3429.2 5620.6 5653.9 5695.1 5705.7 5716.1 5591.6 5650.7 5673.1 5684.3 5701.3 5147.0 5186.9 5188.1 5257.4 5294.5 5125.1 5223.7 5296.6 5329.0 5337.9 5113.5 5119.3 5150.2 5195.5 5238.0 5147.9 5186.1 5198.4 5208.5 5211.7 5093.7 5114.0 5152.8 5205.4 5246.3 5490.2 5506.8 5544.0 5548.7 5590.7 5963.9 5974.0 5974.1 5982.5 5991.5 6034.7 6060.2 6067.3 6081.2 6083.6 5587.8 5655.2 5706.4 5724.9 5766.6 6149.3 6162.6 6207.0 6209.4 6232.1 5973.7 5984.5 5992.5 5993.0 6011.2 6054.3 6074.8 6090.3 6093.2 6134.0 6054.2 6065.3 6077.7 6092.2 6101.3 5972.1 5977.9 6005.4 6016.6 6095.8 4505.3 4506.7 4521.5 4522.2 4549.4 4073.5 4085.0 4087.9 4094.1 4129.1 5702.4 5781.9 5867.5 5890.7 5919.0 6024.7 6060.3 6093.4 6114.1 6136.8 5869.5 5891.4 5892.6 5895.0 5907.3 5109.3 5184.9 5221.8 5268.9 5272.7 6329.3 6340.3 6361.0 6378.1 6390.1 6187.5 6188.4 6196.2 6196.4 6214.2 6153.4 6324.0 6347.8 6350.7 6422.2 5987.9 6017.2 6019.2 6044.7 6062.9 6076.1 6128.7 6139.7 6141.2 6147.4 5792.7 5902.5 5945.4 5958.5 5998.6 5846.0 5849.6 5854.1 5884.3 5899.4 5725.2 5752.8 5812.6 5835.5 5839.2 5918.2 5999.4 6026.7 6030.8 6033.1 5826.3 5860.1 5864.6 5882.8 5896.1 10:53:05 INFO - PROCESS | 3801 | 10:53:05 INFO - PROCESS | 3801 | [#1] ext.html Cycles:180 Average:56907.36 Median:22132.13 stddev:109791.23 (496.1%) stddev-sans-first:110018.00 10:53:05 INFO - PROCESS | 3801 | Values: 661.0 671.6 691.4 711.6 779.0 39251.2 40107.6 40394.4 40581.2 40852.2 39825.8 40575.6 40600.8 40772.2 40819.6 8369.7 8575.9 8633.4 8635.1 8644.7 8400.4 8502.0 8510.3 8512.2 8514.8 8540.4 8557.4 8595.7 8602.3 8611.7 8762.0 8825.5 8829.0 8830.8 8854.9 8548.6 8603.0 8658.0 8662.0 8671.5 35192.8 35699.3 35745.0 35801.5 35831.6 3594.3 3741.1 3756.3 3785.9 3804.8 32657.8 33013.7 33116.0 33512.0 33533.7 3968.1 3978.6 4018.6 4031.1 4034.7 315027.0 315368.0 315409.0 315427.0 315633.0 59493.7 59959.0 60148.0 60262.0 60272.0 69270.3 70615.3 70774.0 71119.6 71203.6 16655.3 16788.2 16819.6 16871.2 16878.5 11044.8 11130.0 11140.3 11168.7 11173.8 19404.5 19967.5 20017.8 20030.0 20653.0 7438.0 7489.2 7551.8 7630.1 7639.5 1102.5 1157.9 1175.9 1186.6 1194.3 32221.5 32637.2 32828.2 33097.3 33328.5 1211.0 1224.3 1240.3 1247.1 1325.1 15809.7 15887.2 15940.4 16017.4 16244.4 440461.0 474323.0 482686.0 484643.0 496275.0 45950.5 46515.0 46539.8 46758.5 46844.0 1461.9 1467.2 1469.7 1499.4 1519.8 27581.3 28428.6 28567.1 29073.9 29136.0 52350.2 52812.7 53097.2 53503.5 53721.2 430566.0 436325.0 436535.0 437394.0 438255.0 30813.2 31039.7 31567.8 31581.4 31659.5 39294.0 39496.0 39667.0 40389.6 40501.6 40423.8 40849.2 41477.6 41792.0 42015.6 40010.8 40233.2 40788.4 41535.4 41631.0 42541.6 42626.0 43645.8 44403.8 44447.3 29447.4 30937.0 30997.2 31001.0 31074.7 25908.5 25918.4 26097.3 26259.5 26379.9 10:53:05 INFO - PROCESS | 3801 | 10:53:05 INFO - PROCESS | 3801 | [#2] jquery.html Cycles:180 Average:28030.60 Median:23911.08 stddev:77716.37 (325.0%) stddev-sans-first:77906.76 10:53:05 INFO - PROCESS | 3801 | Values: 431.1 434.3 435.2 442.1 444.0 17099.4 17806.7 17905.0 17907.6 18361.0 16924.1 16999.1 17199.2 17389.1 17427.7 5769.3 5815.5 6049.7 6053.8 6057.6 5940.0 6059.8 6062.2 6063.0 6096.0 5694.6 5997.3 6020.8 6029.9 6032.4 5813.3 5844.5 5872.2 5886.9 5887.7 5215.8 5263.8 5276.1 5284.0 5284.8 23179.4 23899.9 23922.3 24022.8 24051.8 2511.1 2511.7 2567.8 2580.6 2629.2 14824.2 14921.3 14994.5 15096.5 15154.6 2024.8 2030.6 2082.7 2092.8 2102.7 74747.0 76025.6 77274.6 77400.0 78173.2 11043.3 11238.2 11290.8 11328.5 11532.7 15975.2 16074.1 16185.8 16192.3 16279.8 8751.9 8796.5 8857.3 8964.7 9056.5 8829.2 8832.1 8842.4 8881.3 8964.7 7073.4 7077.3 7081.9 7101.4 7249.7 2024.2 2025.9 2044.3 2067.6 2147.7 1063.1 1102.7 1140.9 1150.2 1218.5 17928.6 19529.2 19629.4 19656.9 20730.8 1104.0 1109.1 1141.1 1154.7 1192.8 11445.2 11525.8 11531.3 11598.2 11605.8 463639.0 470270.0 474397.0 476733.0 486957.0 61453.4 70388.6 72570.6 79369.0 82882.0 1112.5 1123.7 1133.2 1139.4 1144.4 18131.5 18347.4 18546.4 18597.6 18829.6 36689.6 36946.0 37898.6 38543.2 38679.6 51178.0 51367.7 51615.2 51646.5 52531.5 8752.4 8990.9 9000.8 9072.3 9193.9 9741.6 13456.3 13885.4 14075.4 14076.1 11449.1 11922.8 11956.5 12068.7 12162.5 11674.9 12170.3 12239.7 12255.3 12372.8 12410.7 12851.2 12920.1 13003.7 13046.3 8606.5 8872.2 8878.3 9017.8 9128.3 12017.5 12072.1 12126.4 12199.9 12210.6 10:53:05 INFO - PROCESS | 3801 | 10:53:05 INFO - PROCESS | 3801 | [#3] mootools.html Cycles:180 Average:5768.78 Median:4808.65 stddev:3170.10 (65.9%) stddev-sans-first:3162.48 10:53:05 INFO - PROCESS | 3801 | Values: 1463.8 1537.2 1682.5 1823.8 1887.2 7609.8 8101.9 8446.5 8656.5 8670.6 8536.0 8537.4 8599.7 8613.7 8621.3 2420.3 2432.2 2443.5 2453.1 2457.9 2302.8 2340.8 2344.8 2345.2 2402.6 2326.8 2328.5 2345.7 2431.0 2443.9 2423.6 2428.0 2429.5 2433.6 2496.0 2400.5 2411.3 2425.3 2425.5 2436.0 8816.6 8827.3 8836.0 8868.2 8874.4 5352.2 5405.6 5462.0 5489.3 5491.5 3484.7 3542.1 3546.7 3558.5 3621.6 1134.3 1135.2 1141.2 1146.0 1149.5 12411.8 12473.2 12518.4 12525.7 12566.1 4655.9 4729.5 4801.3 4803.4 4805.1 10627.2 10648.7 10655.0 10676.4 10686.1 5448.7 5462.3 5470.8 5476.9 5497.4 4373.7 4812.2 4827.0 4949.6 5008.0 4013.3 4094.7 4133.9 4165.7 4185.3 1399.4 1411.4 1431.7 1442.6 1450.5 1010.6 1022.9 1029.3 1032.7 1034.0 5909.7 6091.5 6165.7 6177.7 6297.8 1025.8 1035.6 1043.4 1045.8 1053.3 4293.7 4320.1 4333.0 4338.6 4352.2 10657.1 11019.6 11087.6 11093.5 11125.6 10018.6 10355.8 11003.2 11058.5 11131.4 7882.7 7891.8 7896.6 7899.5 7957.9 5885.4 6096.5 6108.7 6137.7 6153.2 9039.0 9065.3 9102.0 9108.5 9134.3 9112.5 9309.9 9555.6 9572.0 9584.6 6551.0 7056.9 7177.6 7262.1 7287.2 8025.0 8054.4 8068.8 8090.3 8111.3 7066.9 7390.9 7518.7 7607.0 7677.3 7093.8 7156.9 7214.7 7312.8 7347.0 7224.0 7273.9 7315.5 7362.8 7370.8 5099.8 5224.2 5275.4 5412.4 5433.2 5148.9 5197.3 5261.6 5271.8 5343.0 10:53:05 INFO - PROCESS | 3801 | 10:53:05 INFO - PROCESS | 3801 | [#4] prototype.html Cycles:180 Average:5909.12 Median:6751.53 stddev:1832.68 (27.1%) stddev-sans-first:1789.69 10:53:05 INFO - PROCESS | 3801 | Values: 350.0 350.3 360.1 360.6 366.7 6626.1 6638.7 6746.8 6750.1 6811.7 6613.5 6614.4 6644.5 6648.1 6687.6 4791.9 4892.1 4984.6 5027.9 5029.2 5009.1 5010.8 5012.2 5034.2 5050.6 4981.7 4982.4 4982.5 5005.1 5014.7 5021.7 5034.1 5034.5 5037.3 5048.4 4370.2 4380.8 4382.2 4386.6 4394.2 6128.9 6340.3 6350.2 6409.6 6419.3 5674.7 5688.9 5693.5 5696.7 5721.7 7078.0 7084.9 7085.5 7089.7 7092.0 4686.1 4693.2 4694.8 4698.3 4732.4 7192.2 7306.1 7308.5 7359.8 7362.8 4870.3 4884.5 4888.9 4900.2 4900.2 4907.8 4940.2 4951.7 4954.4 4954.6 5754.1 5758.1 5771.2 5773.9 5775.0 7024.3 7066.5 7073.1 7078.2 7083.2 1685.9 1714.1 1715.4 1716.3 1717.4 1096.8 1110.9 1151.0 1151.0 1154.4 6715.0 6728.2 6753.0 6771.7 6783.5 7213.6 7280.7 7298.5 7332.5 7391.1 6872.1 6886.1 6887.9 6917.7 6943.9 3963.5 3992.4 3999.2 4010.4 4026.2 7710.5 7710.6 7726.3 7773.0 7809.9 7398.1 7522.4 7564.3 7569.7 7590.8 7613.1 7646.4 7667.6 7676.3 7684.2 7302.0 7383.5 7385.1 7393.9 7396.9 7228.6 7255.5 7291.1 7298.7 7307.9 7466.6 7655.2 7679.9 7682.2 7701.7 4894.5 4910.6 4924.5 4933.7 4940.4 7359.7 7404.1 7422.3 7431.0 7438.1 7121.5 7145.6 7161.9 7167.6 7202.8 7017.8 7159.9 7162.1 7162.2 7176.9 6969.9 6975.3 6992.4 6993.9 7035.0 7174.5 7177.8 7239.1 7254.0 7260.6 6854.8 7006.9 7026.6 7038.6 7066.7 10:53:05 INFO - PROCESS | 3801 | 10:53:05 INFO - PROCESS | 3801 | [#5] yui.html Cycles:180 Average:15027.59 Median:4500.77 stddev:17188.54 (381.9%) stddev-sans-first:17204.05 10:53:05 INFO - PROCESS | 3801 | Values: 905.9 909.7 933.7 937.7 950.9 14946.0 14952.8 15244.0 15521.2 15627.1 14623.6 14680.8 14688.8 14712.5 14747.0 872.8 891.6 907.5 909.5 910.7 925.3 927.2 927.3 927.5 928.1 948.6 951.2 951.5 951.5 953.3 942.9 948.9 949.3 949.4 950.2 692.0 692.7 697.4 698.0 698.4 14756.1 14788.8 14885.3 14924.3 14957.9 14655.0 14668.4 14701.4 14745.5 14774.9 12037.6 12037.9 12102.8 12138.9 12305.3 3976.6 4006.7 4036.1 4045.7 4061.3 54188.5 54491.2 55014.4 55245.0 55861.0 10804.9 10959.1 11066.9 11135.4 11365.1 19553.6 19850.3 19918.0 19937.2 19976.9 8259.8 8288.1 8328.9 8372.6 8761.0 4269.7 4422.1 4437.3 4559.4 4584.0 3647.7 3688.7 3694.4 3695.9 3702.9 674.1 676.9 701.9 703.2 704.2 639.9 756.4 788.3 797.4 817.2 9301.5 9328.0 9482.6 9692.7 9725.1 637.8 788.6 792.9 793.0 793.4 4243.3 4481.6 4488.1 4513.4 4574.1 60505.7 61241.7 61419.4 61929.4 62267.4 53068.7 54771.0 55135.4 55308.7 56069.7 49252.5 49330.5 49363.3 50165.5 50256.0 8658.3 8739.2 8980.0 9019.9 9078.9 37316.0 37904.0 38104.8 38372.0 38665.4 43683.6 43717.1 46290.3 48319.3 49146.5 10856.6 11141.9 11372.2 11400.2 11422.1 12242.6 12313.6 12508.0 12754.3 13091.5 11926.7 11929.7 12013.4 12212.6 12304.6 11792.4 11875.3 11956.0 12000.2 12057.3 11577.8 11981.4 12891.5 13203.5 13315.1 9500.1 9579.6 11027.1 11095.2 11339.2 11043.7 11070.6 11171.3 11342.0 11510.7 10:53:05 INFO - PROCESS | 3801 | -------- Summary: end -------- 10:53:05 INFO - PROCESS | 3801 | 10:53:05 INFO - TEST-INFO | 3801: exit 0 10:53:05 INFO - TEST-OK | dromaeo_css | took 1108542ms 10:53:05 INFO - TEST-START | kraken 10:53:05 INFO - operating with platform_type : linux_ 10:53:05 INFO - Initialising browser for kraken test... 10:53:05 INFO - TEST-INFO | started process 4046 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbXDR6b/profile http://localhost:50940/getInfo.html) 10:53:09 INFO - PROCESS | 4046 | 10:53:09 INFO - PROCESS | 4046 | (process:4124): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:53:09 INFO - PROCESS | 4046 | __metrics Screen width/height:1600/1200 10:53:09 INFO - PROCESS | 4046 | colorDepth:24 10:53:09 INFO - PROCESS | 4046 | Browser inner width/height: 1024/697 10:53:09 INFO - PROCESS | 4046 | __metrics 10:53:10 ERROR - PROCESS | 4046 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 10:53:11 INFO - TEST-INFO | 4046: exit 0 10:53:11 INFO - Browser initialized. 10:53:11 INFO - Running cycle 1/1 for kraken test... 10:53:11 INFO - TEST-INFO | started process 4175 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbXDR6b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:13 INFO - PROCESS | 4175 | 10:53:13 INFO - PROCESS | 4175 | (process:4244): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:53:23 INFO - PROCESS | 4175 | RSS: Main: 152375296 10:53:23 INFO - PROCESS | 4175 | 10:53:25 INFO - PROCESS | 4175 | Cycle 1(1): loaded http://localhost:50940/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50940/tests/kraken/driver.html?testName=audio-beat-detection) 10:53:26 INFO - PROCESS | 4175 | RSS: Main: 157102080 10:53:26 INFO - PROCESS | 4175 | 10:53:29 INFO - PROCESS | 4175 | Cycle 1(1): loaded http://localhost:50940/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50940/tests/kraken/driver.html?testName=audio-dft) 10:53:29 INFO - PROCESS | 4175 | RSS: Main: 157708288 10:53:29 INFO - PROCESS | 4175 | 10:53:32 INFO - PROCESS | 4175 | Cycle 1(1): loaded http://localhost:50940/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50940/tests/kraken/driver.html?testName=audio-fft) 10:53:33 INFO - PROCESS | 4175 | RSS: Main: 157290496 10:53:33 INFO - PROCESS | 4175 | 10:53:35 INFO - PROCESS | 4175 | Cycle 1(1): loaded http://localhost:50940/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50940/tests/kraken/driver.html?testName=audio-oscillator) 10:53:35 INFO - PROCESS | 4175 | RSS: Main: 157270016 10:53:35 INFO - PROCESS | 4175 | 10:53:38 INFO - PROCESS | 4175 | Cycle 1(1): loaded http://localhost:50940/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50940/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:53:38 INFO - PROCESS | 4175 | RSS: Main: 157151232 10:53:38 INFO - PROCESS | 4175 | 10:53:41 INFO - PROCESS | 4175 | Cycle 1(1): loaded http://localhost:50940/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50940/tests/kraken/driver.html?testName=imaging-darkroom) 10:53:42 INFO - PROCESS | 4175 | RSS: Main: 157704192 10:53:42 INFO - PROCESS | 4175 | 10:53:45 INFO - PROCESS | 4175 | Cycle 1(1): loaded http://localhost:50940/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50940/tests/kraken/driver.html?testName=imaging-desaturate) 10:53:46 INFO - PROCESS | 4175 | RSS: Main: 157036544 10:53:46 INFO - PROCESS | 4175 | 10:53:49 INFO - PROCESS | 4175 | Cycle 1(1): loaded http://localhost:50940/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50940/tests/kraken/driver.html?testName=json-parse-financial) 10:53:49 INFO - PROCESS | 4175 | RSS: Main: 157511680 10:53:49 INFO - PROCESS | 4175 | 10:53:51 INFO - PROCESS | 4175 | Cycle 1(1): loaded http://localhost:50940/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50940/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:53:52 INFO - PROCESS | 4175 | RSS: Main: 157970432 10:53:52 INFO - PROCESS | 4175 | 10:53:53 INFO - PROCESS | 4175 | Cycle 1(1): loaded http://localhost:50940/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50940/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:53:54 INFO - PROCESS | 4175 | RSS: Main: 157802496 10:53:54 INFO - PROCESS | 4175 | 10:53:56 INFO - PROCESS | 4175 | Cycle 1(1): loaded http://localhost:50940/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50940/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:53:57 INFO - PROCESS | 4175 | RSS: Main: 157593600 10:53:57 INFO - PROCESS | 4175 | 10:53:59 INFO - PROCESS | 4175 | Cycle 1(1): loaded http://localhost:50940/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50940/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:54:00 INFO - PROCESS | 4175 | RSS: Main: 157900800 10:54:00 INFO - PROCESS | 4175 | 10:54:02 INFO - PROCESS | 4175 | Cycle 1(1): loaded http://localhost:50940/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50940/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:54:03 INFO - PROCESS | 4175 | RSS: Main: 157863936 10:54:03 INFO - PROCESS | 4175 | 10:54:05 INFO - PROCESS | 4175 | Cycle 1(1): loaded http://localhost:50940/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50940/tests/kraken/driver.html?testName=ai-astar) 10:54:05 INFO - PROCESS | 4175 | RSS: Main: 159469568 10:54:05 INFO - PROCESS | 4175 | 10:54:05 INFO - PROCESS | 4175 | __start_tp_report 10:54:05 INFO - PROCESS | 4175 | _x_x_mozilla_page_load 10:54:05 INFO - PROCESS | 4175 | _x_x_mozilla_page_load_details 10:54:05 INFO - PROCESS | 4175 | |i|pagename|runs| 10:54:05 INFO - PROCESS | 4175 | |0;ai-astar;109;110;103;110;111;113;102;110;110;111 10:54:05 INFO - PROCESS | 4175 | |1;audio-beat-detection;156;126;150;189;128;155;151;131;198;127 10:54:05 INFO - PROCESS | 4175 | |2;audio-dft;161;163;163;162;161;161;163;162;161;161 10:54:05 INFO - PROCESS | 4175 | |3;audio-fft;74;76;76;170;74;77;76;77;160;76 10:54:05 INFO - PROCESS | 4175 | |4;audio-oscillator;93;93;152;106;92;93;150;94;94;145 10:54:05 INFO - PROCESS | 4175 | |5;imaging-gaussian-blur;117;122;118;118;117;117;117;117;117;118 10:54:05 INFO - PROCESS | 4175 | |6;imaging-darkroom;146;147;148;147;146;147;146;147;147;147 10:54:05 INFO - PROCESS | 4175 | |7;imaging-desaturate;96;96;96;95;95;96;95;95;95;95 10:54:05 INFO - PROCESS | 4175 | |8;json-parse-financial;54;59;55;55;55;58;55;71;58;54 10:54:05 INFO - PROCESS | 4175 | |9;json-stringify-tinderbox;57;58;58;58;59;58;59;59;58;58 10:54:05 INFO - PROCESS | 4175 | |10;stanford-crypto-aes;75;75;73;81;82;76;75;82;84;74 10:54:05 INFO - PROCESS | 4175 | |11;stanford-crypto-ccm;115;117;118;132;115;123;121;124;129;138 10:54:05 INFO - PROCESS | 4175 | |12;stanford-crypto-pbkdf2;164;161;161;171;168;161;163;161;161;159 10:54:05 INFO - PROCESS | 4175 | |13;stanford-crypto-sha256-iterative;66;68;70;68;67;68;68;69;66;68 10:54:05 INFO - PROCESS | 4175 | __end_tp_report 10:54:05 INFO - PROCESS | 4175 | __start_cc_report 10:54:05 INFO - PROCESS | 4175 | _x_x_mozilla_cycle_collect,860 10:54:05 INFO - PROCESS | 4175 | __end_cc_report 10:54:05 INFO - PROCESS | 4175 | __startTimestamp1464630845535__endTimestamp 10:54:05 INFO - PROCESS | 4175 | 10:54:05 INFO - PROCESS | 4175 | ------- Summary: start ------- 10:54:05 INFO - PROCESS | 4175 | Number of tests: 14 10:54:05 INFO - PROCESS | 4175 | 10:54:05 INFO - PROCESS | 4175 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:3.54 (3.2%) stddev-sans-first:3.76 10:54:05 INFO - PROCESS | 4175 | Values: 109.0 110.0 103.0 110.0 111.0 113.0 102.0 110.0 110.0 111.0 10:54:05 INFO - PROCESS | 4175 | 10:54:05 INFO - PROCESS | 4175 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:153.00 stddev:25.44 (16.6%) stddev-sans-first:26.92 10:54:05 INFO - PROCESS | 4175 | Values: 156.0 126.0 150.0 189.0 128.0 155.0 151.0 131.0 198.0 127.0 10:54:05 INFO - PROCESS | 4175 | 10:54:05 INFO - PROCESS | 4175 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 10:54:05 INFO - PROCESS | 4175 | Values: 161.0 163.0 163.0 162.0 161.0 161.0 163.0 162.0 161.0 161.0 10:54:05 INFO - PROCESS | 4175 | 10:54:05 INFO - PROCESS | 4175 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:37.72 (49.6%) stddev-sans-first:39.33 10:54:05 INFO - PROCESS | 4175 | Values: 74.0 76.0 76.0 170.0 74.0 77.0 76.0 77.0 160.0 76.0 10:54:05 INFO - PROCESS | 4175 | 10:54:05 INFO - PROCESS | 4175 | [#4] audio-oscillator Cycles:10 Average:111.20 Median:93.00 stddev:26.44 (28.4%) stddev-sans-first:27.22 10:54:05 INFO - PROCESS | 4175 | Values: 93.0 93.0 152.0 106.0 92.0 93.0 150.0 94.0 94.0 145.0 10:54:05 INFO - PROCESS | 4175 | 10:54:05 INFO - PROCESS | 4175 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:117.50 stddev:1.55 (1.3%) stddev-sans-first:1.62 10:54:05 INFO - PROCESS | 4175 | Values: 117.0 122.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 10:54:05 INFO - PROCESS | 4175 | 10:54:05 INFO - PROCESS | 4175 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 10:54:05 INFO - PROCESS | 4175 | Values: 146.0 147.0 148.0 147.0 146.0 147.0 146.0 147.0 147.0 147.0 10:54:05 INFO - PROCESS | 4175 | 10:54:05 INFO - PROCESS | 4175 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:54:05 INFO - PROCESS | 4175 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 10:54:05 INFO - PROCESS | 4175 | 10:54:05 INFO - PROCESS | 4175 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:56.50 stddev:5.10 (9.0%) stddev-sans-first:5.26 10:54:05 INFO - PROCESS | 4175 | Values: 54.0 59.0 55.0 55.0 55.0 58.0 55.0 71.0 58.0 54.0 10:54:05 INFO - PROCESS | 4175 | 10:54:05 INFO - PROCESS | 4175 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 10:54:05 INFO - PROCESS | 4175 | Values: 57.0 58.0 58.0 58.0 59.0 58.0 59.0 59.0 58.0 58.0 10:54:05 INFO - PROCESS | 4175 | 10:54:05 INFO - PROCESS | 4175 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:78.50 stddev:4.06 (5.2%) stddev-sans-first:4.18 10:54:05 INFO - PROCESS | 4175 | Values: 75.0 75.0 73.0 81.0 82.0 76.0 75.0 82.0 84.0 74.0 10:54:05 INFO - PROCESS | 4175 | 10:54:05 INFO - PROCESS | 4175 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:123.50 stddev:7.71 (6.2%) stddev-sans-first:7.59 10:54:05 INFO - PROCESS | 4175 | Values: 115.0 117.0 118.0 132.0 115.0 123.0 121.0 124.0 129.0 138.0 10:54:05 INFO - PROCESS | 4175 | 10:54:05 INFO - PROCESS | 4175 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:162.00 stddev:3.74 (2.3%) stddev-sans-first:3.95 10:54:05 INFO - PROCESS | 4175 | Values: 164.0 161.0 161.0 171.0 168.0 161.0 163.0 161.0 161.0 159.0 10:54:05 INFO - PROCESS | 4175 | 10:54:05 INFO - PROCESS | 4175 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.12 10:54:05 INFO - PROCESS | 4175 | Values: 66.0 68.0 70.0 68.0 67.0 68.0 68.0 69.0 66.0 68.0 10:54:05 INFO - PROCESS | 4175 | -------- Summary: end -------- 10:54:05 INFO - PROCESS | 4175 | 10:54:06 INFO - TEST-INFO | 4175: exit 0 10:54:06 INFO - TEST-OK | kraken | took 60781ms 10:54:06 INFO - SUITE-END | took 1169s 10:54:06 INFO - Completed test suite (00:19:29) 10:54:06 INFO - javascript benchmark 10:54:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3326.9667303326964, 3388.068281222664, 3395.830208489575, 3406.5571475708152, 3429.245565975486, 5620.606557540974, 5653.943460565393, 5695.088785794269, 5705.74324155413, 5716.114002329635, 5591.608587398873, 5650.6892120933435, 5673.092305231164, 5684.317881854173, 5701.258836351279, 5147.0477961577135, 5186.948130518685, 5188.0920838853235, 5257.421683614818, 5294.497022782849, 5125.103106956286, 5223.738813059351, 5296.576273898079, 5329.0, 5337.919931201035, 5113.488651134875, 5119.308893299412, 5150.227465880129, 5195.454477279888, 5238.00477909198, 5147.871303217431, 5186.1442861927735, 5198.428172900978, 5208.453112423179, 5211.7133557654315, 5093.694378337274, 5114.0, 5152.793888244466, 5205.427402985669, 5246.31797866275, 5490.231367608538, 5506.752196151183, 5544.0, 5548.667079975215, 5590.692511911843, 5963.880722385528, 5973.970130149365, 5974.133750606138, 5982.491488223506, 5991.520678345765, 6034.6982650867285, 6060.181875446802, 6067.302260240085, 6081.239845019372, 6083.574149809515, 5587.832365029056, 5655.208270842086, 5706.400827913051, 5724.856878577985, 5766.567507436917, 6149.292831324455, 6162.630242185483, 6206.968965155235, 6209.441150296495, 6232.0963460298, 5973.671448070311, 5984.461398474158, 5992.460678538865, 5993.041113421831, 6011.248593925759, 6054.334023257438, 6074.848128796815, 6090.299615544269, 6093.207882975274, 6134.04922237054, 6054.152418661391, 6065.302490213594, 6077.6961151943115, 6092.1775560299675, 6101.328853826076, 5972.074328479092, 5977.850553736192, 6005.3694362091355, 6016.578839481194, 6095.847603809941, 4505.279155335131, 4506.729596224237, 4521.547845215518, 4522.208613492626, 4549.40857688505, 4073.450084238649, 4085.0, 4087.8978025549004, 4094.140230551558, 4129.132882094794, 5702.401247868997, 5781.855453613609, 5867.471927526458, 5890.705464726747, 5919.023361145449, 6024.728887200086, 6060.272767267956, 6093.39066093396, 6114.145302971568, 6136.7948077883175, 5869.4717475427415, 5891.410858914074, 5892.587518873724, 5895.0, 5907.2911250650195, 5109.335786347825, 5184.948150518522, 5221.817236396708, 5268.868278293074, 5272.657277276965, 6329.303776584572, 6340.302566717657, 6360.968195158995, 6378.107065010902, 6390.105385246069, 6187.535934804818, 6188.381161883955, 6196.1635179250225, 6196.411340922605, 6214.161088253028, 6153.4154255345675, 6323.9683801580695, 6347.841303967438, 6350.682465876595, 6422.165118534561, 5987.88024239504, 6017.217761690952, 6019.154580562689, 6044.7279872406725, 6062.878742425215, 6076.1493390924425, 6128.662923539248, 6139.72371243304, 6141.170941922784, 6147.385261473817, 5792.681402522901, 5902.498287645598, 5945.435183657545, 5958.493528050164, 5998.580099393001, 5846.0, 5849.64902105875, 5854.092615644582, 5884.264466941632, 5899.380565040609, 5725.19847221381, 5752.769889204553, 5812.622179558315, 5835.533157347317, 5839.153322768259, 5918.201042859159, 5999.370066142992, 6026.698665066817, 6030.819075427744, 6033.095035744674, 5826.329972053099, 5860.09168578871, 5864.618799778001, 5882.794102206402, 5896.086106653475], "value": 5607.507338375423, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.9933900660993, 671.6339594920768, 691.3777600159858, 711.5623891306844, 779.0184367696701, 39251.214975700466, 40107.59892401075, 40394.394084088686, 40581.188376232494, 40852.182956340854, 39825.80087099568, 40575.59424405755, 40600.79699601498, 40772.18455630886, 40819.59180408195, 8369.665213391458, 8575.914240857604, 8633.3524985626, 8635.093315201877, 8644.697435589756, 8400.369972252074, 8502.0, 8510.319174466058, 8512.191341822549, 8514.787130321729, 8540.402171847942, 8557.358198135134, 8595.742127736146, 8602.2688071514, 8611.698590549331, 8762.036176020632, 8825.470471771681, 8828.955855220747, 8830.779230519223, 8854.86717699235, 8548.57257137147, 8602.956985215034, 8658.04761476237, 8662.047174810767, 8671.523066231355, 35192.824035879916, 35699.28601427983, 35745.0, 35801.46297805535, 35831.64168358309, 3594.26317604893, 3741.1395379062697, 3756.323861704892, 3785.886423407302, 3804.7907365094907, 32657.836710816533, 33013.66986330154, 33116.0, 33512.0, 33533.664663353295, 3968.0873399118364, 3978.6021397860272, 4018.598140185958, 4031.072853243741, 4034.677225821927, 315026.99999999773, 315368.0, 315409.0, 315427.0, 315633.0, 59493.70253148793, 59959.0, 60148.0, 60262.0, 60272.0, 69270.30729692739, 70615.2938470619, 70774.0, 71119.6444017787, 71203.6439817808, 16655.25051372691, 16788.160591970354, 16819.57951051209, 16871.156442177842, 16878.493645190665, 11044.779104417867, 11130.0, 11140.33158010522, 11168.66494005181, 11173.776524469466, 19404.514887127934, 19967.500812479804, 20017.799822001885, 20030.0, 20653.0, 7438.0, 7489.213632568611, 7551.773446796605, 7630.084389873251, 7639.465237433437, 1102.5038732570376, 1157.8610566732045, 1175.905927525796, 1186.602488166474, 1194.3431112887877, 32221.51667724986, 32637.18407039843, 32828.1792955178, 33097.338053239284, 33328.50007249893, 1211.0, 1224.2593231095236, 1240.342618412243, 1247.114548670436, 1325.1121748428577, 15809.68380632404, 15887.205639717968, 15940.442084526985, 16017.359305627644, 16244.350225990827, 440461.0, 474323.0, 482686.0, 484643.0, 496275.0, 45950.54049459463, 46515.0, 46539.76730116328, 46758.5324146761, 46844.0, 1461.926903654813, 1467.207707837777, 1469.7060587882465, 1499.392745937897, 1519.8480151984934, 27581.31046723848, 28428.57357139603, 28567.14298570963, 29073.85463072671, 29136.0, 52350.21474677807, 52812.735936320074, 53097.20354194613, 53503.46496534985, 53721.19418208808, 430566.0, 436325.0, 436535.0, 437394.0, 438255.0, 30813.22966925845, 31039.689603104584, 31567.84216078905, 31581.368372631958, 31659.52510712295, 39294.0, 39496.0, 39667.0, 40389.59610403858, 40501.594984050964, 40423.7978810104, 40849.18301633891, 41477.578878044944, 41792.0, 42015.579844201166, 40010.79994600009, 40233.1953360937, 40788.38817417682, 41535.37696934488, 41631.0, 42541.57458425376, 42626.0, 43645.78177109221, 44403.77798111118, 44447.33329000003, 29447.411051779272, 30937.0, 30997.225069373446, 31001.0, 31074.68925310718, 25908.481830363664, 25918.35204119912, 26097.347566310993, 26259.4748105033, 26379.86810066014], "value": 19759.593217031746, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.0559377208787, 434.30294377524075, 435.19271750902055, 442.1356248534116, 444.03201021772526, 17099.40152094677, 17806.732899006493, 17905.0, 17907.641847163064, 18361.0, 16924.069176195306, 16999.065051422167, 17199.226034828433, 17389.13054347284, 17427.73858392125, 5769.278840144982, 5815.534757219423, 6049.6672683002635, 6053.848653783669, 6057.575969682124, 5939.970300148493, 6059.787907423241, 6062.18160548327, 6062.969295219823, 6095.969520152393, 5694.601377903548, 5997.340292567814, 6020.849478763044, 6029.939700602981, 6032.426919442668, 5813.331466881321, 5844.503217226498, 5872.236609240814, 5886.941130588682, 5887.676177810219, 5215.843524694265, 5263.789448422059, 5276.076686579871, 5284.0, 5284.841454756363, 23179.420514487105, 23899.88050059756, 23922.282331529907, 24022.7597724024, 24051.7594824053, 2511.1085564624477, 2511.748825117492, 2567.7560631739957, 2580.5742052561304, 2629.18495266468, 14824.184669843155, 14921.328540215607, 14994.47519336829, 15096.54710358691, 15154.621134471616, 2024.8481363897768, 2030.644637188486, 2082.6980087887323, 2092.780258072896, 2102.7161333219974, 74747.0, 76025.61987190084, 77274.61362693207, 77399.99999999943, 78173.21826781717, 11043.282186657842, 11238.21332506733, 11290.774184516427, 11328.490217940212, 11532.711682208012, 15975.201239937956, 16074.115923624078, 16185.83814161867, 16192.271347789378, 16279.755803662954, 8751.912480875237, 8796.47221166732, 8857.335699822539, 8964.68623598171, 9056.50189239585, 8829.16122968317, 8832.072632373509, 8842.425242359226, 8881.333899957399, 8964.68623598171, 7073.434125269966, 7077.292270772881, 7081.92918070823, 7101.396381307647, 7249.6950548901705, 2024.200440825895, 2025.8885761282977, 2044.2845004248395, 2067.5809303115393, 2147.6563749799957, 1063.1335461598926, 1102.7077824376547, 1140.9389267980857, 1150.1833698074295, 1218.5125949620224, 17928.55178620519, 19529.21883124659, 19629.411117666492, 19656.918869462315, 20730.792692073188, 1103.9944800276107, 1109.1348747976592, 1141.1156353825686, 1154.717094311899, 1192.8330033795276, 11445.198836081561, 11525.76948461026, 11531.263568174052, 11598.246114002563, 11605.76788464226, 463639.0, 470270.0, 474397.0, 476733.0, 486957.0, 61453.38546614566, 70388.64805675938, 72570.63714681393, 79369.0, 82882.0, 1112.5160555158532, 1123.719070232442, 1133.206755271297, 1139.3619573039125, 1144.3648774929993, 18131.54671133232, 18347.357842475983, 18546.44360669182, 18597.628047438706, 18829.623407532046, 36689.633103668624, 36946.0, 37898.62101379061, 38543.22913541769, 38679.61320386873, 51178.0, 51367.74316128396, 51615.225771612706, 51646.48353516417, 52531.47468525419, 8752.431091979, 8990.86513702282, 9000.819983600422, 9072.255532867843, 9193.86209206849, 9741.610335586498, 13456.25990570528, 13885.375158118111, 14075.366608502438, 14076.085054471836, 11449.08407327395, 11922.821157682469, 11956.521739130338, 12068.698282542655, 12162.452689629165, 11674.94162529182, 12170.330631815335, 12239.69400764988, 12255.264684118982, 12372.81440778407, 12410.689732756753, 12851.16467429614, 12920.095593308753, 13003.674908127372, 13046.347682615642, 8606.526641034803, 8872.157145071207, 8878.289736820909, 9017.819643607223, 9128.315376346667, 12017.519299227934, 12072.094592905392, 12126.393680315772, 12199.939000304941, 12210.572629958264], "value": 9637.216029517995, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.7511623024088, 1537.1699282387508, 1682.5434865096959, 1823.8358547730709, 1887.1885089411549, 7609.8478030439355, 8101.918980810205, 8446.535440550775, 8656.52389118599, 8670.609822557984, 8535.957320213405, 8537.4450660707, 8599.699010534632, 8613.655453781857, 8621.310295176387, 2420.298113547069, 2432.221689059502, 2443.4990826880535, 2453.129139155601, 2457.9016839326405, 2302.8370672810206, 2340.8361414700976, 2344.8006919411787, 2345.1909091363455, 2402.627592723122, 2326.8022218111482, 2328.4877326988035, 2345.7067866516686, 2431.0, 2443.853368797869, 2423.5758742220128, 2427.963580546293, 2429.4776623026046, 2433.586290330648, 2495.9750402495924, 2400.543896659629, 2411.3007227903886, 2425.333033415807, 2425.466397392571, 2435.975640243593, 8816.603252853636, 8827.293816494664, 8836.0, 8868.15752503511, 8874.378793484459, 5352.2239275305255, 5405.594580406485, 5462.0, 5489.258950041733, 5491.478309560625, 3484.686378225972, 3542.079059444537, 3546.716262698978, 3558.5373901392913, 3621.5654121505327, 1134.2513940799115, 1135.188340336655, 1141.2296699727733, 1146.0373286439349, 1149.494222542087, 12411.75176496474, 12473.189242699285, 12518.374081295899, 12525.686857828536, 12566.05754568402, 4655.86032419028, 4729.4797572267025, 4801.327814106028, 4803.423589169322, 4805.111054454867, 10627.202959778047, 10648.680539583826, 10655.0, 10676.359418434919, 10686.091682206945, 5448.673079615236, 5462.317210348707, 5470.753816078286, 5476.863078423071, 5497.367802702661, 4373.737575745402, 4812.181929072066, 4826.975865120652, 4949.628777841676, 5008.023435430129, 4013.337799263147, 4094.6724262058965, 4133.855315063958, 4165.687573432005, 4185.309423945015, 1399.4472183487464, 1411.4213172599184, 1431.7422863884601, 1442.5888621742754, 1450.52132796177, 1010.5654568535454, 1022.8721409823772, 1029.3463650581934, 1032.736652153696, 1033.9896601034043, 5909.704514774244, 6091.51267898567, 6165.722542485599, 6177.6911154443, 6297.842553936097, 1025.7743296474764, 1035.6427032673716, 1043.3739756146404, 1045.7699306152633, 1053.3100818963592, 4293.656507479394, 4320.1143765527995, 4333.025069359432, 4338.609525142752, 4352.194843953878, 10657.147428205724, 11019.559217631366, 11087.556497740161, 11093.500792464198, 11125.554977800959, 10018.64934727281, 10355.844662330072, 11003.17476189289, 11058.502367393487, 11131.443427828575, 7882.684692612232, 7891.802704932423, 7896.60516974149, 7899.486533375312, 7957.880631790527, 5885.440883116097, 6096.481799047131, 6108.664023478751, 6137.693115344304, 6153.230846144232, 9039.0, 9065.27477801761, 9101.954490227772, 9108.499032553273, 9134.269258459175, 9112.498812565373, 9309.86035209486, 9555.61777528891, 9572.042795720372, 9584.616615335308, 6550.967245163934, 7056.894146587702, 7177.569345839266, 7262.055932728923, 7287.161976372785, 8025.0, 8054.3556515479795, 8068.798280043045, 8090.312323452337, 8111.310538604049, 7066.893996590158, 7390.926090739239, 7518.699252029857, 7607.049118860143, 7677.347425468898, 7093.787186384417, 7156.928430715626, 7214.74748383804, 7312.81717957034, 7347.0, 7224.0, 7273.927260727537, 7315.524490908074, 7362.815929601803, 7370.815729606803, 5099.770510327118, 5224.242484839753, 5275.419703832498, 5412.404635490172, 5433.185022246695, 5148.922766158586, 5197.298364720866, 5261.552768014762, 5271.762770675252, 5343.038253114477], "value": 4700.158552409187, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.9912502187445, 350.34835206515874, 360.1015466411304, 360.56731921693955, 366.7121309771828, 6626.105475760771, 6638.668066596669, 6746.76386326478, 6750.088738020366, 6811.659417029141, 6613.470922326214, 6614.3716346947085, 6644.468442524599, 6648.135742353499, 6687.632180230085, 4791.928121078178, 4892.070506603752, 4984.576311013569, 5027.924581131286, 5029.2456131580375, 5009.073321435546, 5010.799568017275, 5012.223105418648, 5034.169362055257, 5050.646454748169, 4981.676191047571, 4982.427020892607, 4982.5017498250245, 5005.1491246488185, 5014.674046187004, 5021.723805190713, 5034.11902916988, 5034.521720436571, 5037.269595908591, 5048.368953880765, 4370.235208838472, 4380.802863871133, 4382.167388196232, 4386.583274588909, 4394.209042372372, 6128.938710612882, 6340.334264902165, 6350.174477317965, 6409.583377080521, 6419.293877673452, 5674.744636491327, 5688.857778555528, 5693.459121383462, 5696.658200507983, 5721.6853073080965, 7078.044463997346, 7084.92915070853, 7085.504014718972, 7089.71641134354, 7092.042574252461, 4686.08621318843, 4693.225617773098, 4694.765261736899, 4698.318743782167, 4732.432108147044, 7192.208857025776, 7306.050213472267, 7308.524945878554, 7359.8160045999275, 7362.77911662651, 4870.342503761947, 4884.4871288514905, 4888.902221955612, 4900.240462728283, 4900.240462728283, 4907.779149938261, 4940.1601727706375, 4951.678140920829, 4954.405471343462, 4954.554090131834, 5754.05058165398, 5758.107493338539, 5771.249737534177, 5773.855653608609, 5774.971125144348, 7024.262452442522, 7066.50534462593, 7073.115860517435, 7078.1860086090755, 7083.220845706968, 1685.8988460692399, 1714.1086634950007, 1715.3996101364423, 1716.2705850013945, 1717.3559915031863, 1096.8080585897435, 1110.8666959964855, 1150.9539618415338, 1150.9769804603861, 1154.3766366162179, 6715.0, 6728.226253980855, 6752.966235168891, 6771.661416929134, 6783.525153239325, 7213.603251821095, 7280.745173918887, 7298.52559583636, 7332.450066245053, 7391.113066431955, 6872.10662613857, 6886.10480637524, 6887.896681549781, 6917.7232910684015, 6943.861122777516, 3963.524377074712, 3992.401139828991, 3999.1801680655394, 4010.4184893190322, 4026.2350153471334, 7710.537367757953, 7710.614469276514, 7726.266004729542, 7772.961135194288, 7809.882851757228, 7398.075240594926, 7522.398208143335, 7564.281393267631, 7569.659365328574, 7590.81022974419, 7613.124490683532, 7646.3882889368715, 7667.616619169019, 7676.2707542784465, 7684.231576842383, 7302.0142280791415, 7383.520071195355, 7385.076865391826, 7393.8890916637365, 7396.852062958818, 7228.63856807147, 7255.52839065459, 7291.125064992235, 7298.671559779928, 7307.926920730937, 7466.552006879605, 7655.196204398458, 7679.923200767921, 7682.231776822273, 7701.691932322644, 4894.4616092230535, 4910.5580497753945, 4924.50754924519, 4933.679310844784, 4940.431850337257, 7359.668814903235, 7404.148522919718, 7422.294881986203, 7430.96284518574, 7438.144613369532, 7121.537100088478, 7145.571265724073, 7161.892571611325, 7167.605781682058, 7202.819929501804, 7017.789466316019, 7159.8568028640175, 7162.06893103914, 7162.247963963709, 7176.928230717626, 6969.895451568332, 6975.267596902455, 6992.405645520188, 6993.895091573529, 7034.964825175842, 7174.497785154989, 7177.820554485971, 7239.095113110861, 7254.0, 7260.636968151465, 6854.828629284308, 7006.948957656392, 7026.648667566704, 7038.577685338896, 7066.681999310146], "value": 5301.766184107054, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [905.9229965452936, 909.7043460875213, 933.7058826469662, 937.7139972308445, 950.9096635819596, 14946.0, 14952.77570836437, 15244.0, 15521.22393880307, 15627.140507272095, 14623.561293161196, 14680.779788303184, 14688.779668304984, 14712.485063022796, 14747.0, 872.8428882801124, 891.5898686604154, 907.4736652741427, 909.5179554835914, 910.713125365511, 925.296774451415, 927.1562877781221, 927.2767241551601, 927.5455027036737, 928.0626567167142, 948.6252930092609, 951.1914872358475, 951.4529145741227, 951.4957072751453, 953.3421938862198, 942.8821397325335, 948.928830337724, 949.264320151881, 949.4113649537262, 950.1828427552299, 691.9515633905629, 692.6813665713778, 697.4106879686657, 697.9685914133876, 698.3714656808862, 14756.114633122046, 14788.778168327484, 14885.330160142712, 14924.328405221791, 14957.850421495863, 14655.0, 14668.413263469449, 14701.411943522353, 14745.483908063274, 14774.852251477563, 12037.638870833889, 12037.939810300892, 12102.81845772314, 12138.939305303416, 12305.26168429897, 3976.5824588418377, 4006.7395619284653, 4036.1120553478186, 4045.656119229869, 4061.289274376972, 54188.45811541873, 54491.18263226015, 55014.449855501734, 55245.0, 55861.0, 10804.891951080546, 10959.123270138529, 11066.944665276784, 11135.387553684463, 11365.147613928988, 19553.60892782165, 19850.305239316556, 19918.0, 19937.202511899362, 19976.90011549933, 8259.793505162299, 8288.129746376664, 8328.875066874001, 8372.623231954576, 8760.956195218983, 4269.743815371025, 4422.137683151755, 4437.33439984005, 4559.4072770539615, 4583.977080114578, 3647.6899463545897, 3688.6680198782237, 3694.3904255797493, 3695.870644527429, 3702.851885924587, 674.1193757197852, 676.9356911093438, 701.9227884932653, 703.2405002597183, 704.225352112672, 639.8688268904864, 756.3911051603512, 788.3259812860036, 797.3820289275858, 817.2154731457748, 9301.488418137067, 9328.0, 9482.620695172116, 9692.70921872345, 9725.0761177688, 637.8437282865635, 788.5662885413, 792.8691765858684, 792.9563873986987, 793.3811626931004, 4243.342281946303, 4481.619062379669, 4488.102379524108, 4513.435820522434, 4574.130915126116, 60505.69747151236, 61241.693791531645, 61419.38580614226, 61929.38070619236, 62267.37732622616, 53068.73465632647, 54771.0, 55135.44864551383, 55308.72345638246, 56069.719651402294, 49252.50747492551, 49330.50669493331, 49363.25955110676, 50165.498345016815, 50255.999999999265, 8658.264047556027, 8739.169778870997, 8980.012198658273, 9019.909800901907, 9078.909210907806, 37316.0, 37904.0, 38104.80947595244, 38372.040698982746, 38665.42001869918, 43683.56316436922, 43717.12565748731, 46290.30564541467, 48319.27521087257, 49146.50853491562, 10856.565737370416, 11141.944290278821, 11372.203945724052, 11400.201985860911, 11422.143339249757, 12242.632721018384, 12313.630591082281, 12508.0, 12754.29851358147, 13091.476340946256, 11926.701832454259, 11929.701757456132, 12013.399330033639, 12212.633620991384, 12304.569340073054, 11792.351420671603, 11875.287482751062, 11956.0, 12000.1599888007, 12057.336846473178, 11577.768444631229, 11981.400929953641, 12891.548795792101, 13203.537876174289, 13315.06794524374, 9500.097490738368, 9579.568919398504, 11027.117830573696, 11095.22333436684, 11339.169231075604, 11043.738217343101, 11070.557177713123, 11171.273867198606, 11342.0, 11510.654680359603], "value": 6998.0019739114805, "unit": "score"}], "name": "dromaeo_css", "value": 7556.843647747371, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 103.0, 110.0, 111.0, 113.0, 102.0, 110.0, 110.0, 111.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 150.0, 189.0, 128.0, 155.0, 151.0, 131.0, 198.0, 127.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 162.0, 161.0, 161.0, 163.0, 162.0, 161.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 170.0, 74.0, 77.0, 76.0, 77.0, 160.0, 76.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 152.0, 106.0, 92.0, 93.0, 150.0, 94.0, 94.0, 145.0], "value": 111.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 122.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 55.0, 55.0, 55.0, 58.0, 55.0, 71.0, 58.0, 54.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 59.0, 58.0, 59.0, 59.0, 58.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 73.0, 81.0, 82.0, 76.0, 75.0, 82.0, 84.0, 74.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 118.0, 132.0, 115.0, 123.0, 121.0, 124.0, 129.0, 138.0], "value": 123.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 161.0, 171.0, 168.0, 161.0, 163.0, 161.0, 161.0, 159.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 70.0, 68.0, 67.0, 68.0, 68.0, 69.0, 66.0, 68.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1533.9, "alertThreshold": 2.0}]} 10:54:06 INFO - Return code: 0 10:54:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:54:06 ERROR - # TBPL SUCCESS # 10:54:06 INFO - Running post-action listener: _resource_record_post_action 10:54:06 INFO - Running post-run listener: _resource_record_post_run 10:54:07 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 514232320; Read time: 12; Write time: 385008 10:54:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249163776; Read time: 0; Write time: 227560 10:54:07 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250826752; Read time: 12; Write time: 154784 10:54:07 INFO - Running post-run listener: _upload_blobber_files 10:54:07 INFO - Blob upload gear active. 10:54:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:54:07 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 10:54:07 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'] 10:54:07 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 10:54:08 INFO - (blobuploader) - INFO - Open directory for files ... 10:54:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:54:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:54:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:54:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:54:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:54:09 INFO - (blobuploader) - INFO - Done attempting. 10:54:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:54:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:54:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:54:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:54:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:54:09 INFO - (blobuploader) - INFO - Done attempting. 10:54:09 INFO - (blobuploader) - INFO - Iteration through files over. 10:54:09 INFO - Return code: 0 10:54:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:54:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:54:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/114e96732dc904752ff0d13ceabe5a0c89f88d10c19de2e73f582a26933fe6794ed2fab2de823c765dc4a6602b5a08b80faad04981fe6774b2a5199fd98a5aa5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f44aa12f05182221ac518b800a67ca54a4f0a89c35e93aa477ceeb15be38041f75b63e3cbd88b2ed49ef28317e49254abe3aa106459bca1de40361fdf0fa9dfb"} 10:54:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:54:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:54:09 INFO - Contents: 10:54:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/114e96732dc904752ff0d13ceabe5a0c89f88d10c19de2e73f582a26933fe6794ed2fab2de823c765dc4a6602b5a08b80faad04981fe6774b2a5199fd98a5aa5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f44aa12f05182221ac518b800a67ca54a4f0a89c35e93aa477ceeb15be38041f75b63e3cbd88b2ed49ef28317e49254abe3aa106459bca1de40361fdf0fa9dfb"} 10:54:09 INFO - Running post-run listener: copy_logs_to_upload_dir 10:54:09 INFO - Copying logs to upload dir... 10:54:09 INFO - mkdir: /builds/slave/test/build/upload/logs 10:54:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.674851 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-05-30 10:54:09.688704) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 10:54:09.691983) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/114e96732dc904752ff0d13ceabe5a0c89f88d10c19de2e73f582a26933fe6794ed2fab2de823c765dc4a6602b5a08b80faad04981fe6774b2a5199fd98a5aa5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f44aa12f05182221ac518b800a67ca54a4f0a89c35e93aa477ceeb15be38041f75b63e3cbd88b2ed49ef28317e49254abe3aa106459bca1de40361fdf0fa9dfb"} build_url:https://queue.taskcluster.net/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/YHYNW5dNRR2z7jx_WNNEkg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/114e96732dc904752ff0d13ceabe5a0c89f88d10c19de2e73f582a26933fe6794ed2fab2de823c765dc4a6602b5a08b80faad04981fe6774b2a5199fd98a5aa5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f44aa12f05182221ac518b800a67ca54a4f0a89c35e93aa477ceeb15be38041f75b63e3cbd88b2ed49ef28317e49254abe3aa106459bca1de40361fdf0fa9dfb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 10:54:09.717992) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:54:09.718328) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1464629623.697293-1389264323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 10:54:09.800791) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 10:54:09.801152) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 10:54:09.801471) ========= ========= Total master_lag: 0.17 =========