builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1464430296.54 results: success (0) buildid: 20160525152143 builduid: 8654ccbbea454f27b451ee4808dca30e revision: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:36.542459) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:36.542938) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:36.543215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:36.557503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:36.557788) ========= 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=0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-28 03:11:37-- 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% 113M=0s 2016-05-28 03:11:37 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.307451 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:36.878483) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:36.878913) ========= 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=0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014823 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:36.928139) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 03:11:36.928503) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-28 03:11:37,535 truncating revision to first 12 chars 2016-05-28 03:11:37,535 Setting DEBUG logging. 2016-05-28 03:11:37,535 attempt 1/10 2016-05-28 03:11:37,535 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4f7c3a2567f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 03:11:38,527 unpacking tar archive at: mozilla-aurora-4f7c3a2567f8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.353630 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 03:11:38.295634) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:38.295956) ========= script_repo_revision: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:38.296339) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:38.296624) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:11:38.304960) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-28 03:11:38.305253) ========= /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=0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:11:38 INFO - MultiFileLogger online at 20160528 03:11:38 in /builds/slave/test 03:11:38 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 03:11:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:11:38 INFO - {'append_to_log': False, 03:11:38 INFO - 'base_work_dir': '/builds/slave/test', 03:11:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:11:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:11:38 INFO - 'branch': 'Mozilla-Aurora', 03:11:38 INFO - 'buildbot_json_path': 'buildprops.json', 03:11:38 INFO - 'config_files': ('talos/linux_config.py',), 03:11:38 INFO - 'default_actions': ('clobber', 03:11:38 INFO - 'read-buildbot-config', 03:11:38 INFO - 'download-and-extract', 03:11:38 INFO - 'populate-webroot', 03:11:38 INFO - 'create-virtualenv', 03:11:38 INFO - 'install', 03:11:38 INFO - 'run-tests'), 03:11:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:11:38 INFO - 'download_minidump_stackwalk': True, 03:11:38 INFO - 'download_symbols': 'ondemand', 03:11:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:11:38 INFO - 'tooltool.py': '/tools/tooltool.py', 03:11:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:11:38 INFO - '/tools/misc-python/virtualenv.py')}, 03:11:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:11:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:11:38 INFO - 'installer_path': 'installer.exe', 03:11:38 INFO - 'log_level': 'info', 03:11:38 INFO - 'log_name': 'talos', 03:11:38 INFO - 'log_to_console': True, 03:11:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:11:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:11:38 INFO - 'opt_config_files': (), 03:11:38 INFO - 'pip_index': False, 03:11:39 INFO - 'sps_profile': False, 03:11:39 INFO - 'sps_profile_interval': 0, 03:11:39 INFO - 'suite': 'dromaeojs-e10s', 03:11:39 INFO - 'system_bits': '32', 03:11:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:11:39 INFO - 'title': 'talos-linux64-ix-017', 03:11:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:11:39 INFO - 'use_talos_json': True, 03:11:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:11:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:11:39 INFO - 'work_dir': 'build'} 03:11:39 INFO - ##### 03:11:39 INFO - ##### Running clobber step. 03:11:39 INFO - ##### 03:11:39 INFO - Running pre-action listener: _resource_record_pre_action 03:11:39 INFO - Running main action method: clobber 03:11:39 INFO - rmtree: /builds/slave/test/build 03:11:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:11:39 INFO - Running post-action listener: _resource_record_post_action 03:11:39 INFO - ##### 03:11:39 INFO - ##### Running read-buildbot-config step. 03:11:39 INFO - ##### 03:11:39 INFO - Running pre-action listener: _resource_record_pre_action 03:11:39 INFO - Running main action method: read_buildbot_config 03:11:39 INFO - Using buildbot properties: 03:11:39 INFO - { 03:11:39 INFO - "project": "", 03:11:39 INFO - "product": "firefox", 03:11:39 INFO - "script_repo_revision": "production", 03:11:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:11:39 INFO - "repository": "", 03:11:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:11:39 INFO - "buildid": "20160525152143", 03:11:39 INFO - "pgo_build": "True", 03:11:39 INFO - "basedir": "/builds/slave/test", 03:11:39 INFO - "buildnumber": 297, 03:11:39 INFO - "slavename": "talos-linux64-ix-017", 03:11:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:11:39 INFO - "platform": "ubuntu64_hw", 03:11:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:11:39 INFO - "branch": "mozilla-aurora", 03:11:39 INFO - "repo_path": "releases/mozilla-aurora", 03:11:39 INFO - "revision": "4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3", 03:11:39 INFO - "stage_platform": "linux64-pgo", 03:11:39 INFO - "builduid": "8654ccbbea454f27b451ee4808dca30e", 03:11:39 INFO - "slavebuilddir": "test" 03:11:39 INFO - } 03:11:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:11:39 INFO - Running post-action listener: _resource_record_post_action 03:11:39 INFO - ##### 03:11:39 INFO - ##### Running download-and-extract step. 03:11:39 INFO - ##### 03:11:39 INFO - Running pre-action listener: _resource_record_pre_action 03:11:39 INFO - Running main action method: download_and_extract 03:11:39 INFO - mkdir: /builds/slave/test/build/tests 03:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:39 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:11:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:11:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:11:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:11:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:11:40 INFO - Downloaded 1361 bytes. 03:11:40 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:11:40 INFO - Using the following test package requirements: 03:11:40 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:11:40 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:11:40 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:11:40 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:40 INFO - u'jsshell-linux-x86_64.zip'], 03:11:40 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:11:40 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:11:40 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:11:40 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:11:40 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:11:40 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:11:40 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:11:40 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:40 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:11:41 INFO - Downloaded 24135950 bytes. 03:11:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:11:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:11:42 INFO - Return code: 0 03:11:42 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:42 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:11:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:11:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:11:43 INFO - Downloaded 24135950 bytes. 03:11:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:11:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:11:45 INFO - Return code: 0 03:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:45 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:11:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:11:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:11:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:11:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:11:46 INFO - Downloaded 10840145 bytes. 03:11:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:11:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:11:46 INFO - Return code: 0 03:11: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')]} 03:11:46 INFO - https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:11:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:11:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:11:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:11:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:11:47 INFO - Downloaded 62768089 bytes. 03:11:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:11:47 INFO - mkdir: /builds/slave/test/properties 03:11:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:11:47 INFO - Writing to file /builds/slave/test/properties/build_url 03:11:47 INFO - Contents: 03:11:47 INFO - build_url:https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:11:52 INFO - Running post-action listener: _resource_record_post_action 03:11:52 INFO - Running post-action listener: set_extra_try_arguments 03:11:52 INFO - ##### 03:11:52 INFO - ##### Running populate-webroot step. 03:11:52 INFO - ##### 03:11:52 INFO - Running pre-action listener: _resource_record_pre_action 03:11:52 INFO - Running main action method: populate_webroot 03:11:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:11:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:11:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:11:52 INFO - '--tppagecycles', 03:11:52 INFO - '7'], 03:11:52 INFO - 'tests': ['tsvgm']}}, 03:11:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:11:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:11:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:11:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:11:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:11:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:11:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:52 INFO - 'talos_options': ['--disable-e10s'], 03:11:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:52 INFO - 'talos_options': ['--disable-e10s'], 03:11:52 INFO - 'tests': ['damp', 'tps']}, 03:11:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:52 INFO - 'tests': ['damp', 'tps']}, 03:11:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:11:52 INFO - 'tests': ['dromaeo_dom']}, 03:11:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:11:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:11:52 INFO - 'tests': ['a11yr', 03:11:52 INFO - 'ts_paint', 03:11:52 INFO - 'tpaint', 03:11:52 INFO - 'sessionrestore', 03:11:52 INFO - 'sessionrestore_no_auto_restore', 03:11:52 INFO - 'tabpaint']}, 03:11:52 INFO - 'other-e10s': {'tests': ['a11yr', 03:11:52 INFO - 'ts_paint', 03:11:52 INFO - 'tpaint', 03:11:52 INFO - 'sessionrestore', 03:11:52 INFO - 'sessionrestore_no_auto_restore', 03:11:52 INFO - 'tabpaint']}, 03:11:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:11:52 INFO - 'ts_paint', 03:11:52 INFO - 'tpaint', 03:11:52 INFO - 'sessionrestore', 03:11:52 INFO - 'sessionrestore_no_auto_restore', 03:11:52 INFO - 'tabpaint']}, 03:11:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:11:52 INFO - 'ts_paint', 03:11:52 INFO - 'tpaint', 03:11:52 INFO - 'sessionrestore', 03:11:52 INFO - 'sessionrestore_no_auto_restore', 03:11:52 INFO - 'tabpaint']}, 03:11:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:11:52 INFO - 'tests': ['a11yr', 03:11:52 INFO - 'ts_paint', 03:11:52 INFO - 'tpaint', 03:11:52 INFO - 'sessionrestore', 03:11:52 INFO - 'sessionrestore_no_auto_restore', 03:11:52 INFO - 'tabpaint']}, 03:11:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:11:52 INFO - 'tests': ['a11yr', 03:11:52 INFO - 'ts_paint', 03:11:52 INFO - 'tpaint', 03:11:52 INFO - 'sessionrestore', 03:11:52 INFO - 'sessionrestore_no_auto_restore', 03:11:52 INFO - 'tabpaint']}, 03:11:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:11:52 INFO - 'tests': ['tsvgx', 03:11:52 INFO - 'tsvgr_opacity', 03:11:52 INFO - 'tart', 03:11:52 INFO - 'tscrollx', 03:11:52 INFO - 'cart']}, 03:11:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:11:52 INFO - 'tsvgr_opacity', 03:11:52 INFO - 'tart', 03:11:52 INFO - 'tscrollx', 03:11:52 INFO - 'cart']}, 03:11:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:52 INFO - 'talos_options': ['--disable-e10s'], 03:11:52 INFO - 'tests': ['tp5o']}, 03:11:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:52 INFO - 'tests': ['tp5o']}, 03:11:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:52 INFO - 'talos_options': ['--disable-e10s', 03:11:52 INFO - '--xperf_path', 03:11:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:52 INFO - 'tests': ['tp5n']}, 03:11:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:52 INFO - 'talos_options': ['--xperf_path', 03:11:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:52 INFO - 'tests': ['tp5n']}}, 03:11:52 INFO - 'talos.zip': {'path': '', 03:11:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:11:52 INFO - Running post-action listener: _resource_record_post_action 03:11:52 INFO - ##### 03:11:52 INFO - ##### Running create-virtualenv step. 03:11:52 INFO - ##### 03:11:52 INFO - Running pre-action listener: _resource_record_pre_action 03:11:52 INFO - Running main action method: create_virtualenv 03:11:52 INFO - Creating virtualenv /builds/slave/test/build/venv 03:11:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:11:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:11:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:11:52 INFO - Using real prefix '/usr' 03:11:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:11:52 INFO - Installing distribute.............................................................................................................................................................................................done. 03:11:54 INFO - Installing pip.................done. 03:11:54 INFO - Return code: 0 03:11:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:54 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 0x7f7d9aac6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2410>, '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 0x14f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f37a0>, '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': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:11:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:11:54 INFO - Using env: {'DISPLAY': ':0', 03:11:54 INFO - 'HOME': '/home/cltbld', 03:11:54 INFO - 'LANG': 'en_US.UTF-8', 03:11:54 INFO - 'LANGUAGE': 'en_US:en', 03:11:54 INFO - 'LOGNAME': 'cltbld', 03:11:54 INFO - 'MAIL': '/var/mail/cltbld', 03:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:54 INFO - 'MOZ_NO_REMOTE': '1', 03:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:54 INFO - 'NO_EM_RESTART': '1', 03:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:54 INFO - 'PWD': '/builds/slave/test', 03:11:54 INFO - 'SHELL': '/bin/bash', 03:11:54 INFO - 'SHLVL': '1', 03:11:54 INFO - 'TERM': 'linux', 03:11:54 INFO - 'TMOUT': '86400', 03:11:54 INFO - 'USER': 'cltbld', 03:11:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 03:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:54 INFO - '_': '/tools/buildbot/bin/python'} 03:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:11:54 INFO - Cleaning up... 03:11:54 INFO - Return code: 0 03:11:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:54 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 0x7f7d9aac6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2410>, '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 0x14f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f37a0>, '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': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:11:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:11:54 INFO - Using env: {'DISPLAY': ':0', 03:11:54 INFO - 'HOME': '/home/cltbld', 03:11:54 INFO - 'LANG': 'en_US.UTF-8', 03:11:54 INFO - 'LANGUAGE': 'en_US:en', 03:11:54 INFO - 'LOGNAME': 'cltbld', 03:11:54 INFO - 'MAIL': '/var/mail/cltbld', 03:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:54 INFO - 'MOZ_NO_REMOTE': '1', 03:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:54 INFO - 'NO_EM_RESTART': '1', 03:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:54 INFO - 'PWD': '/builds/slave/test', 03:11:54 INFO - 'SHELL': '/bin/bash', 03:11:54 INFO - 'SHLVL': '1', 03:11:54 INFO - 'TERM': 'linux', 03:11:54 INFO - 'TMOUT': '86400', 03:11:54 INFO - 'USER': 'cltbld', 03:11:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 03:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:54 INFO - '_': '/tools/buildbot/bin/python'} 03:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:55 INFO - Downloading/unpacking psutil>=0.7.1 03:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:11:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:57 INFO - Installing collected packages: psutil 03:11:57 INFO - Running setup.py install for psutil 03:11:57 INFO - building 'psutil._psutil_linux' extension 03:11:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:11:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:11:57 INFO - building 'psutil._psutil_posix' extension 03:11:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:11:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:11:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:57 INFO - Successfully installed psutil 03:11:57 INFO - Cleaning up... 03:11:57 INFO - Return code: 0 03:11:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:57 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 0x7f7d9aac6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2410>, '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 0x14f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f37a0>, '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': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:11:57 INFO - Using env: {'DISPLAY': ':0', 03:11:57 INFO - 'HOME': '/home/cltbld', 03:11:57 INFO - 'LANG': 'en_US.UTF-8', 03:11:57 INFO - 'LANGUAGE': 'en_US:en', 03:11:57 INFO - 'LOGNAME': 'cltbld', 03:11:57 INFO - 'MAIL': '/var/mail/cltbld', 03:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:57 INFO - 'MOZ_NO_REMOTE': '1', 03:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:57 INFO - 'NO_EM_RESTART': '1', 03:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:57 INFO - 'PWD': '/builds/slave/test', 03:11:57 INFO - 'SHELL': '/bin/bash', 03:11:57 INFO - 'SHLVL': '1', 03:11:57 INFO - 'TERM': 'linux', 03:11:57 INFO - 'TMOUT': '86400', 03:11:57 INFO - 'USER': 'cltbld', 03:11:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 03:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:57 INFO - '_': '/tools/buildbot/bin/python'} 03:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:11:59 INFO - Installing collected packages: mozsystemmonitor 03:11:59 INFO - Running setup.py install for mozsystemmonitor 03:11:59 INFO - Successfully installed mozsystemmonitor 03:11:59 INFO - Cleaning up... 03:11:59 INFO - Return code: 0 03:11:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7d9aac6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2410>, '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 0x14f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f37a0>, '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': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:11:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:11:59 INFO - Using env: {'DISPLAY': ':0', 03:11:59 INFO - 'HOME': '/home/cltbld', 03:11:59 INFO - 'LANG': 'en_US.UTF-8', 03:11:59 INFO - 'LANGUAGE': 'en_US:en', 03:11:59 INFO - 'LOGNAME': 'cltbld', 03:11:59 INFO - 'MAIL': '/var/mail/cltbld', 03:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:59 INFO - 'MOZ_NO_REMOTE': '1', 03:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:59 INFO - 'NO_EM_RESTART': '1', 03:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:59 INFO - 'PWD': '/builds/slave/test', 03:11:59 INFO - 'SHELL': '/bin/bash', 03:11:59 INFO - 'SHLVL': '1', 03:11:59 INFO - 'TERM': 'linux', 03:11:59 INFO - 'TMOUT': '86400', 03:11:59 INFO - 'USER': 'cltbld', 03:11:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 03:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:59 INFO - '_': '/tools/buildbot/bin/python'} 03:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:00 INFO - Downloading/unpacking blobuploader==1.2.4 03:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:01 INFO - Downloading blobuploader-1.2.4.tar.gz 03:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:12:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:12:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:02 INFO - Downloading docopt-0.6.1.tar.gz 03:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:12:02 INFO - Installing collected packages: blobuploader, requests, docopt 03:12:02 INFO - Running setup.py install for blobuploader 03:12:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:12:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:12:02 INFO - Running setup.py install for requests 03:12:03 INFO - Running setup.py install for docopt 03:12:03 INFO - Successfully installed blobuploader requests docopt 03:12:03 INFO - Cleaning up... 03:12:03 INFO - Return code: 0 03:12:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:12: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')]} 03:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12: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')]} 03:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:03 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 0x7f7d9aac6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2410>, '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 0x14f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f37a0>, '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': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:12:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:12:03 INFO - Using env: {'DISPLAY': ':0', 03:12:03 INFO - 'HOME': '/home/cltbld', 03:12:03 INFO - 'LANG': 'en_US.UTF-8', 03:12:03 INFO - 'LANGUAGE': 'en_US:en', 03:12:03 INFO - 'LOGNAME': 'cltbld', 03:12:03 INFO - 'MAIL': '/var/mail/cltbld', 03:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:03 INFO - 'MOZ_NO_REMOTE': '1', 03:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:03 INFO - 'NO_EM_RESTART': '1', 03:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:03 INFO - 'PWD': '/builds/slave/test', 03:12:03 INFO - 'SHELL': '/bin/bash', 03:12:03 INFO - 'SHLVL': '1', 03:12:03 INFO - 'TERM': 'linux', 03:12:03 INFO - 'TMOUT': '86400', 03:12:03 INFO - 'USER': 'cltbld', 03:12:03 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 03:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:03 INFO - '_': '/tools/buildbot/bin/python'} 03:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:12:03 INFO - Running setup.py (path:/tmp/pip-bfyDyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:12:03 INFO - Running setup.py (path:/tmp/pip-JV1akK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:12:03 INFO - Running setup.py (path:/tmp/pip-CfLK1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:12:03 INFO - Running setup.py (path:/tmp/pip-ZlvLV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:12:03 INFO - Running setup.py (path:/tmp/pip-99OHyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:12:03 INFO - Running setup.py (path:/tmp/pip-rhtZIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:12:03 INFO - Running setup.py (path:/tmp/pip-UZED6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:12:04 INFO - Running setup.py (path:/tmp/pip-1hWPfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:12:04 INFO - Running setup.py (path:/tmp/pip-qDWxI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:12:04 INFO - Running setup.py (path:/tmp/pip-9x5zY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:12:04 INFO - Running setup.py (path:/tmp/pip-5mXsJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:12:04 INFO - Running setup.py (path:/tmp/pip-fFDVTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:12:04 INFO - Running setup.py (path:/tmp/pip-FCe73Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:12:04 INFO - Running setup.py (path:/tmp/pip-JYUkCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:04 INFO - Running setup.py (path:/tmp/pip-_oR6Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:12:04 INFO - Running setup.py (path:/tmp/pip-Ktk8IG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:12:04 INFO - Running setup.py (path:/tmp/pip-4T6clE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:12:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:12:04 INFO - Running setup.py install for manifestparser 03:12:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:12:04 INFO - Running setup.py install for mozcrash 03:12:04 INFO - Running setup.py install for mozdebug 03:12:05 INFO - Running setup.py install for mozdevice 03:12:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:12:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:12:05 INFO - Running setup.py install for mozfile 03:12:05 INFO - Running setup.py install for mozhttpd 03:12:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:12:05 INFO - Running setup.py install for mozinfo 03:12:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:12:05 INFO - Running setup.py install for mozInstall 03:12:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:12:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:12:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:12:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:12:05 INFO - Running setup.py install for mozleak 03:12:05 INFO - Running setup.py install for mozlog 03:12:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:12:05 INFO - Running setup.py install for moznetwork 03:12:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:12:05 INFO - Running setup.py install for mozprocess 03:12:05 INFO - Running setup.py install for mozprofile 03:12:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:12:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:12:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:12:06 INFO - Running setup.py install for mozrunner 03:12:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:12:06 INFO - Running setup.py install for mozscreenshot 03:12:06 INFO - Running setup.py install for moztest 03:12:06 INFO - Running setup.py install for mozversion 03:12:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:12:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:12:06 INFO - Cleaning up... 03:12:06 INFO - Return code: 0 03:12:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:06 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 0x7f7d9aac6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2410>, '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 0x14f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f37a0>, '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': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:12:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:12:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:12:06 INFO - Using env: {'DISPLAY': ':0', 03:12:06 INFO - 'HOME': '/home/cltbld', 03:12:06 INFO - 'LANG': 'en_US.UTF-8', 03:12:06 INFO - 'LANGUAGE': 'en_US:en', 03:12:06 INFO - 'LOGNAME': 'cltbld', 03:12:06 INFO - 'MAIL': '/var/mail/cltbld', 03:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:06 INFO - 'MOZ_NO_REMOTE': '1', 03:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:06 INFO - 'NO_EM_RESTART': '1', 03:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:06 INFO - 'PWD': '/builds/slave/test', 03:12:06 INFO - 'SHELL': '/bin/bash', 03:12:06 INFO - 'SHLVL': '1', 03:12:06 INFO - 'TERM': 'linux', 03:12:06 INFO - 'TMOUT': '86400', 03:12:06 INFO - 'USER': 'cltbld', 03:12:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 03:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:06 INFO - '_': '/tools/buildbot/bin/python'} 03:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:12:06 INFO - Running setup.py (path:/tmp/pip-HdjG0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:12:06 INFO - Running setup.py (path:/tmp/pip-llMCxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:12:06 INFO - Running setup.py (path:/tmp/pip-fKP03C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:12:06 INFO - Running setup.py (path:/tmp/pip-WWOOfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:12:07 INFO - Running setup.py (path:/tmp/pip-A4YSDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:12:07 INFO - Running setup.py (path:/tmp/pip-pwzRxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:12:07 INFO - Running setup.py (path:/tmp/pip-scBTj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:12:07 INFO - Running setup.py (path:/tmp/pip-v0J684-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:12:07 INFO - Running setup.py (path:/tmp/pip-FGadex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:12:07 INFO - Running setup.py (path:/tmp/pip-LWXJFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:12:07 INFO - Running setup.py (path:/tmp/pip-YK39bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:12:07 INFO - Running setup.py (path:/tmp/pip-stOleZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:12:07 INFO - Running setup.py (path:/tmp/pip-Q41ilS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:12:07 INFO - Running setup.py (path:/tmp/pip-mkTyYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:07 INFO - Running setup.py (path:/tmp/pip-Czvnxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:12:07 INFO - Running setup.py (path:/tmp/pip-NdtTJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:12:07 INFO - Running setup.py (path:/tmp/pip-BfhrsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:12:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:09 INFO - Downloading blessings-1.6.tar.gz 03:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:12:09 INFO - Installing collected packages: blessings 03:12:09 INFO - Running setup.py install for blessings 03:12:10 INFO - Successfully installed blessings 03:12:10 INFO - Cleaning up... 03:12:10 INFO - Return code: 0 03:12:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:12:10 INFO - Reading from file tmpfile_stdout 03:12:10 INFO - Current package versions: 03:12:10 INFO - argparse == 1.2.1 03:12:10 INFO - blessings == 1.6 03:12:10 INFO - blobuploader == 1.2.4 03:12:10 INFO - docopt == 0.6.1 03:12:10 INFO - manifestparser == 1.1 03:12:10 INFO - mozInstall == 1.12 03:12:10 INFO - mozcrash == 0.17 03:12:10 INFO - mozdebug == 0.1 03:12:10 INFO - mozdevice == 0.48 03:12:10 INFO - mozfile == 1.2 03:12:10 INFO - mozhttpd == 0.7 03:12:10 INFO - mozinfo == 0.9 03:12:10 INFO - mozleak == 0.1 03:12:10 INFO - mozlog == 3.1 03:12:10 INFO - moznetwork == 0.27 03:12:10 INFO - mozprocess == 0.22 03:12:10 INFO - mozprofile == 0.28 03:12:10 INFO - mozrunner == 6.11 03:12:10 INFO - mozscreenshot == 0.1 03:12:10 INFO - mozsystemmonitor == 0.0 03:12:10 INFO - moztest == 0.7 03:12:10 INFO - mozversion == 1.4 03:12:10 INFO - psutil == 3.1.1 03:12:10 INFO - requests == 1.2.3 03:12:10 INFO - wsgiref == 0.1.2 03:12:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:12: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')]} 03:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12: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')]} 03:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:10 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 0x7f7d9aac6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2410>, '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 0x14f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f37a0>, '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': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:12:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:12:10 INFO - Using env: {'DISPLAY': ':0', 03:12:10 INFO - 'HOME': '/home/cltbld', 03:12:10 INFO - 'LANG': 'en_US.UTF-8', 03:12:10 INFO - 'LANGUAGE': 'en_US:en', 03:12:10 INFO - 'LOGNAME': 'cltbld', 03:12:10 INFO - 'MAIL': '/var/mail/cltbld', 03:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:10 INFO - 'MOZ_NO_REMOTE': '1', 03:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:10 INFO - 'NO_EM_RESTART': '1', 03:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:10 INFO - 'PWD': '/builds/slave/test', 03:12:10 INFO - 'SHELL': '/bin/bash', 03:12:10 INFO - 'SHLVL': '1', 03:12:10 INFO - 'TERM': 'linux', 03:12:10 INFO - 'TMOUT': '86400', 03:12:10 INFO - 'USER': 'cltbld', 03:12:10 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 03:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:10 INFO - '_': '/tools/buildbot/bin/python'} 03:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:12:10 INFO - Cleaning up... 03:12:10 INFO - Return code: 0 03:12:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:12: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')]} 03:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12: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')]} 03:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:10 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 0x7f7d9aac6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2410>, '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 0x14f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f37a0>, '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': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:12:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:12:10 INFO - Using env: {'DISPLAY': ':0', 03:12:10 INFO - 'HOME': '/home/cltbld', 03:12:10 INFO - 'LANG': 'en_US.UTF-8', 03:12:10 INFO - 'LANGUAGE': 'en_US:en', 03:12:10 INFO - 'LOGNAME': 'cltbld', 03:12:10 INFO - 'MAIL': '/var/mail/cltbld', 03:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:10 INFO - 'MOZ_NO_REMOTE': '1', 03:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:10 INFO - 'NO_EM_RESTART': '1', 03:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:10 INFO - 'PWD': '/builds/slave/test', 03:12:10 INFO - 'SHELL': '/bin/bash', 03:12:10 INFO - 'SHLVL': '1', 03:12:10 INFO - 'TERM': 'linux', 03:12:10 INFO - 'TMOUT': '86400', 03:12:10 INFO - 'USER': 'cltbld', 03:12:10 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 03:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:10 INFO - '_': '/tools/buildbot/bin/python'} 03:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:10 INFO - Downloading/unpacking jsonschema 03:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:12:12 INFO - Downloading/unpacking functools32 (from jsonschema) 03:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:12 INFO - Downloading functools32-3.2.3-2.tar.gz 03:12:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:12:12 INFO - warning: no files found matching '*.txt' 03:12:12 INFO - no previously-included directories found matching 'build' 03:12:12 INFO - no previously-included directories found matching 'dist' 03:12:12 INFO - no previously-included directories found matching '.git*' 03:12:12 INFO - Installing collected packages: jsonschema, functools32 03:12:13 INFO - Running setup.py install for functools32 03:12:13 INFO - warning: no files found matching '*.txt' 03:12:13 INFO - no previously-included directories found matching 'build' 03:12:13 INFO - no previously-included directories found matching 'dist' 03:12:13 INFO - no previously-included directories found matching '.git*' 03:12:13 INFO - Successfully installed jsonschema functools32 03:12:13 INFO - Cleaning up... 03:12:13 INFO - Return code: 0 03:12:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:13 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 0x7f7d9aac6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f2410>, '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 0x14f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f37a0>, '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': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:12:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:12:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:12:13 INFO - Using env: {'DISPLAY': ':0', 03:12:13 INFO - 'HOME': '/home/cltbld', 03:12:13 INFO - 'LANG': 'en_US.UTF-8', 03:12:13 INFO - 'LANGUAGE': 'en_US:en', 03:12:13 INFO - 'LOGNAME': 'cltbld', 03:12:13 INFO - 'MAIL': '/var/mail/cltbld', 03:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:13 INFO - 'MOZ_NO_REMOTE': '1', 03:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:13 INFO - 'NO_EM_RESTART': '1', 03:12:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:13 INFO - 'PWD': '/builds/slave/test', 03:12:13 INFO - 'SHELL': '/bin/bash', 03:12:13 INFO - 'SHLVL': '1', 03:12:13 INFO - 'TERM': 'linux', 03:12:13 INFO - 'TMOUT': '86400', 03:12:13 INFO - 'USER': 'cltbld', 03:12:13 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 03:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:13 INFO - '_': '/tools/buildbot/bin/python'} 03:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:13 INFO - Downloading/unpacking flake8 03:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:12:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:12:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:12:15 INFO - no previously-included directories found matching 'docs/_build' 03:12:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:12:16 INFO - Running setup.py install for pep8 03:12:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:12:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:12:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:12:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:12:16 INFO - no previously-included directories found matching 'docs/_build' 03:12:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:12:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:12:16 INFO - Cleaning up... 03:12:16 INFO - Return code: 0 03:12:16 INFO - Running post-action listener: _resource_record_post_action 03:12:16 INFO - Running post-action listener: _start_resource_monitoring 03:12:16 INFO - Starting resource monitoring. 03:12:16 INFO - ##### 03:12:16 INFO - ##### Running install step. 03:12:16 INFO - ##### 03:12:16 INFO - Running pre-action listener: _resource_record_pre_action 03:12:16 INFO - Running main action method: install 03:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:12:16 INFO - Reading from file tmpfile_stdout 03:12:16 INFO - Detecting whether we're running mozinstall >=1.0... 03:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:12:16 INFO - Reading from file tmpfile_stdout 03:12:16 INFO - Output received: 03:12:16 INFO - Usage: mozinstall [options] installer 03:12:16 INFO - Options: 03:12:16 INFO - -h, --help show this help message and exit 03:12:16 INFO - -d DEST, --destination=DEST 03:12:16 INFO - Directory to install application into. [default: 03:12:16 INFO - "/builds/slave/test"] 03:12:16 INFO - --app=APP Application being installed. [default: firefox] 03:12:16 INFO - mkdir: /builds/slave/test/build/application 03:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:12:32 INFO - Reading from file tmpfile_stdout 03:12:32 INFO - Output received: 03:12:32 INFO - /builds/slave/test/build/application/firefox/firefox 03:12:32 INFO - Running post-action listener: _resource_record_post_action 03:12:32 INFO - ##### 03:12:32 INFO - ##### Running run-tests step. 03:12:32 INFO - ##### 03:12:32 INFO - Running pre-action listener: _resource_record_pre_action 03:12:32 INFO - Running main action method: run_tests 03:12:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:12:32 INFO - Python 2.7.3 03:12:32 INFO - Return code: 0 03:12:32 INFO - grabbing minidump binary from tooltool 03:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:32 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 0x14f2410>, '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 0x14f3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:12:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:12:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:12:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:12:32 INFO - Return code: 0 03:12:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:12:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:12:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:12:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:12:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:12:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:12:33 INFO - Return code: 0 03:12:33 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/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 03:12:33 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/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 03:12:33 INFO - Using env: {'DISPLAY': ':0', 03:12:33 INFO - 'HOME': '/home/cltbld', 03:12:33 INFO - 'LANG': 'en_US.UTF-8', 03:12:33 INFO - 'LANGUAGE': 'en_US:en', 03:12:33 INFO - 'LOGNAME': 'cltbld', 03:12:33 INFO - 'MAIL': '/var/mail/cltbld', 03:12:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:12:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:33 INFO - 'MOZ_NO_REMOTE': '1', 03:12:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:33 INFO - 'NO_EM_RESTART': '1', 03:12:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:33 INFO - 'PWD': '/builds/slave/test', 03:12:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:12:33 INFO - 'SHELL': '/bin/bash', 03:12:33 INFO - 'SHLVL': '1', 03:12:33 INFO - 'TERM': 'linux', 03:12:33 INFO - 'TMOUT': '86400', 03:12:33 INFO - 'USER': 'cltbld', 03:12:33 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103', 03:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:33 INFO - '_': '/tools/buildbot/bin/python'} 03:12:33 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/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 03:12:33 INFO - mozversion application_buildid: 20160525152143 03:12:33 INFO - mozversion application_changeset: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 03:12:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:12:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:12:33 INFO - mozversion application_name: Firefox 03:12:33 INFO - mozversion application_remotingname: firefox-dev 03:12:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:12:33 INFO - mozversion application_vendor: Mozilla 03:12:33 INFO - mozversion application_version: 48.0a2 03:12:33 INFO - mozversion platform_buildid: 20160525152143 03:12:33 INFO - mozversion platform_changeset: 4f7c3a2567f88307b10e4b6fc9b0d4b180fe58a3 03:12:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:12:33 INFO - mozversion platform_version: 48.0a2 03:12:33 INFO - using testdate: 1464430353 03:12:33 INFO - actual date: 1464430353 03:12:33 INFO - starting webserver on 'localhost:56665' 03:12:33 INFO - SUITE-START | Running 2 tests 03:12:33 INFO - TEST-START | dromaeo_css 03:12:33 INFO - operating with platform_type : linux_ 03:12:33 INFO - Initialising browser for dromaeo_css test... 03:12:33 INFO - TEST-INFO | started process 12942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE8LuvS/profile http://localhost:56665/getInfo.html) 03:12:36 INFO - PROCESS | 12942 | 03:12:36 INFO - PROCESS | 12942 | (process:13016): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:12:37 INFO - PROCESS | 12942 | __metrics Screen width/height:1600/1200 03:12:37 INFO - PROCESS | 12942 | colorDepth:24 03:12:37 INFO - PROCESS | 12942 | Browser inner width/height: 1024/697 03:12:37 INFO - PROCESS | 12942 | __metrics 03:12:37 ERROR - PROCESS | 12942 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 03:12:38 INFO - TEST-INFO | 12942: exit 0 03:12:38 INFO - Browser initialized. 03:12:38 INFO - Running cycle 1/1 for dromaeo_css test... 03:12:38 INFO - TEST-INFO | started process 13067 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE8LuvS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:40 INFO - PROCESS | 13067 | 03:12:40 INFO - PROCESS | 13067 | (process:13135): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:12:50 INFO - PROCESS | 13067 | RSS: Main: 152481792 03:12:50 INFO - PROCESS | 13067 | 03:13:40 INFO - PROCESS | 13067 | 1464430420036 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:15:47 INFO - PROCESS | 13067 | Cycle 1(1): loaded http://localhost:56665/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56665/tests/dromaeo/cssquery-ext.html) 03:15:48 INFO - PROCESS | 13067 | RSS: Main: 155791360 03:15:48 INFO - PROCESS | 13067 | 03:18:50 INFO - PROCESS | 13067 | Cycle 1(1): loaded http://localhost:56665/tests/dromaeo/cssquery-ext.html (next: http://localhost:56665/tests/dromaeo/cssquery-jquery.html) 03:18:51 INFO - PROCESS | 13067 | RSS: Main: 153894912 03:18:51 INFO - PROCESS | 13067 | 03:21:52 INFO - PROCESS | 13067 | Cycle 1(1): loaded http://localhost:56665/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56665/tests/dromaeo/cssquery-mootools.html) 03:21:53 INFO - PROCESS | 13067 | RSS: Main: 153612288 03:21:53 INFO - PROCESS | 13067 | 03:24:54 INFO - PROCESS | 13067 | Cycle 1(1): loaded http://localhost:56665/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56665/tests/dromaeo/cssquery-prototype.html) 03:24:55 INFO - PROCESS | 13067 | RSS: Main: 153649152 03:24:55 INFO - PROCESS | 13067 | 03:27:57 INFO - PROCESS | 13067 | Cycle 1(1): loaded http://localhost:56665/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56665/tests/dromaeo/cssquery-yui.html) 03:27:58 INFO - PROCESS | 13067 | RSS: Main: 154677248 03:27:58 INFO - PROCESS | 13067 | 03:31:00 INFO - PROCESS | 13067 | Cycle 1(1): loaded http://localhost:56665/tests/dromaeo/cssquery-yui.html (next: http://localhost:56665/tests/dromaeo/cssquery-dojo.html) 03:31:00 INFO - PROCESS | 13067 | RSS: Main: 156753920 03:31:00 INFO - PROCESS | 13067 | 03:31:00 INFO - PROCESS | 13067 | __start_tp_report 03:31:00 INFO - PROCESS | 13067 | _x_x_mozilla_page_load 03:31:00 INFO - PROCESS | 13067 | _x_x_mozilla_page_load_details 03:31:00 INFO - PROCESS | 13067 | |i|pagename|runs| 03:31:00 INFO - PROCESS | 13067 | |0;dojo.html;3384.4077286474867;3414.8463319150637;3442.156671615455;3465.9306813863714;3482.7213822894173;5721.656700597967;5740.454656807602;5790.131480277961;5794;5807.73865176067;5713.428657134285;5777.220075289834;5807.535397168227;5813.098969659699;5831.2419385479825;5156.561692256163;5204.661696989683;5267.683938963655;5269.6311258211945;5283.788648454057;5070.442251352349;5294.1529355303155;5370.248165256867;5376.381716102659;5411.134218525037;5172.379314482268;5186.455422180673;5197.948020519784;5263.631545791777;5279.076161671692;5118.232265160219;5212.9739351303;5218.712970786605;5223.138182199932;5294.629375943686;5133.178691409394;5204.479552044765;5220.921686174673;5221.791128354861;5252.107141785906;5474.178873169017;5498.395176530578;5602.523785478239;5627.831165065055;5641.464060914206;5940.554458415593;5940.673262970535;5946.167536544887;5952.9702351488395;6045.788397406113;6004.78983235589;6010.75956961721;6019.518438524951;6030.96984515079;6040.12418199363;5600.215969764236;5607.7476513556985;5629.774809007635;5633.746481408305;5645.661260324394;6125.081237814364;6140.3552626974415;6142.508599312045;6146.631202127886;6155.415235552616;5894.086416605433;5926.496247818897;5931.139984702194;5931.58478906481;5932.762689492458;6109.495762817221;6195.021057090846;6205.317415084337;6205.689715514206;6223.253209614875;5959.4934430573885;5963.224780778471;5977.342492325841;5980.611260268069;6044.637321760709;5947.31605865331;5948.167256584082;5972.193753843176;6024.337322894478;6029.909551356734;4580.129775342674;4610.861674149781;4636.768161591907;4645.953540464619;4669.2062349400685;4147.543770185277;4147.6267135957305;4154.252234597801;4163.10493243948;4193.412922190834;5864.237649105674;5889.293284805765;5913.76344946206;5968.820935371946;5975;6005.159277701126;6023.096535519707;6079.726412311456;6102.237220347457;6116.244470650255;5918.23063001807;5950;5976.342602313742;5984;6020.247469066367;5200.869978250498;5208.427073021964;5280.577553795687;5318.494742999409;5325.547328477122;6301.180846490019;6347.96826015867;6368.395002474757;6368.713407896656;6380.617162970237;6146.5390095743;6171;6185.6907154641185;6192.2569291683485;6194.163787888578;6258.43674069336;6342.841428964312;6383.39357761012;6398.616083035033;6437.034444833313;6012.158297838394;6013.098035294741;6013.5189184865985;6030.396960303934;6033.9698301508215;6054.390423955979;6082.513398927987;6119.051547010221;6127.264728232462;6135.14108024868;5899;5931.525477961666;5972.193753843176;5980.491658209101;5982.670953097621;5900.232969713909;5929.970350148395;5935.673537955281;5946.256717910262;5967.46292833647;5729.255196824386;5849.210356601974;5856.385079566584;5856.7950121747235;5867;5781.595288329945;5923.970380148072;5942.10868369748;6019.157317975574;6060.424259695322;5886.117082437669;5898.144769008555;5901.498372638202;5942.078977758454;5949.3753155918 03:31:00 INFO - PROCESS | 13067 | |1;ext.html;598.1476396135506;636.7834936121719;652.4714980865498;659.228702418171;684.3601232847291;32474.67525324746;34003.31993360131;34018.319633607345;34101.1474713132;34219.65780342196;34705.305893882105;34724.82637586815;35099.29801403977;35141.82429087851;35208;8427.915720842806;8562.61468233931;8587.785305367353;8614.827703445959;8631.611577479029;8440.28257598105;8695.608697608623;8695.913040869573;8703.173198546128;8735.21383075523;8662.956685216597;8703.825923481527;8772.254358379545;8774;8775.824483510325;8699.652013919436;8718.520481373522;8737.30101591871;8763;8763.912360876406;8687.218150366434;8745.518996455192;8784.868226976601;8798.164174403486;8803.075677053881;32739.50890736641;33380.33239335224;33411.83294083538;33425.49861752076;33491.49762753561;3570.589382221052;3578.4095624221973;3609.3322735294055;3636.654517820803;3743.251349730038;26648;26760.59859102115;26797.732022679913;26893;27580.862095689394;4415.955840441618;4440.755758433284;4469.955300446986;4518.728876267402;4550.635949124062;285806;288164;288938;290804;292731;33202.16994575155;33897.49153762696;49072.75463622659;49225.50774492281;49257;32914.50628240578;32947.67052329494;32967.3406531868;33046.83476582602;33129;13622.727545449035;13708.108972916729;13780.65548361299;13818.861811381757;13846.792298115537;10543.630972915911;10616;10626.787464250672;10640.574377024986;10668.733281668021;8249.546274954815;8344.123866994;8349.874751878726;8354.039285482126;8418.200270974248;3347.0795531229105;3440.4884434362557;3461.7230621550216;3482.2513159670284;3491.6159222485508;1043.8173319669027;1058.433737950193;1091.4542728635681;1098.5770478365887;1182.9290242585473;28823.423531529254;28845.711542884303;29071.709282907323;29074.85462572716;29369;1088.8094583447864;1121.2319561100671;1121.814900541418;1129.9152563557602;1150.2408410449063;15276.541703748906;15360.231988400536;15366;15450.150241736812;15582.45461408868;478091;514473;523304;524061;799924;47465.28802067972;48957.75521122443;49102;49214.261786073235;49382.753086235054;1310.377570653951;1314.1129737427389;1322.0481253497467;1326.157889740022;1342.812006319116;29613.555796662637;29617.851910740308;29881.70118298876;30234.24414389658;30415.847920760254;44215.778921106474;44223.77888110539;44433.11133777371;44524.55475445204;44570.55429445664;417850;418712;420130;420403;424511;27290.72709272882;38644.420333695576;39228;39473.60526394699;39535.20929581335;37934.43098353582;38400.6159938397;38601.6139838598;38881.80559097186;38896.80551597224;32958.835205823816;33297;33654.49518257277;33768;33800.15499612431;33523.497147542315;33699.49450758191;33866.153346166546;33902.66097338995;36233.81883090568;34815.12962175966;35150.472742908365;35299;35382.29235415226;37709.4343584841;31613;32234.83882580572;32273.193170170933;32501.674983249864;34296.82851585726;25072.74927250704;25735.485290293716;25812.09657661973;25973.480530389665;26191.869040654674 03:31:00 INFO - PROCESS | 13067 | |2;jquery.html;391.5986114232912;396.74608250719524;402.4968789013733;403.84451985985396;416.89994401343665;17512.737308940377;17713.214620431125;18226.27094916202;18234.361797337097;18321.81678183221;15277;15787.131707756069;15906.52280431586;15914.442994495195;15939.442119525818;5045.470225626303;5251.264822924793;5261.105612045962;5286.788528458857;5298.708571028592;5152.639315247934;5226.738663066851;5229.450907654698;5237.13587258102;5238.580913526908;5236.162214045753;5430.5384042356445;5695.174199741035;5699.173619825123;5719.027765279912;5610;5644.209810626516;5661.46216109469;5876.647401155901;6243.500519958392;5575.470330318613;5581.2186293918885;5615.298087739033;5632.493075623172;5660.971695141498;13609.931950340284;14818.703625927421;20019.699704504445;20580.5883882323;21419.464513387135;2357.2574638988663;2441.414060625455;2453.4847681986803;2519;2597.5324441600505;10444.582216711322;10618.203634727426;10648.840267395995;10721.731956701067;10935.398553079578;1971.9704204436946;2012.4365177750108;2081.2923605973892;2082.250389859649;2092.5501017281204;73322;74571.99999999946;75212.24787752108;75977.62011189964;76911.61544192299;10560.577576896992;10619.787604247871;10665.146788256921;10888.40113793749;10955.616553420592;15008.924955375152;15025.924870375797;15046.924765376103;15079.321430535652;15133.621659458382;6794.8641027180165;7223.747168849065;7313.780586582411;7466.365358944442;7555.508891922007;7050.153981522148;7095.503314767917;7296;7517.436192285491;7541.4343924205905;4613.308003799457;4689.929651055237;4732.2428411454;4732.384789977281;4781.42622885256;1961.1763059514753;2036.297477370305;2054.845886558514;2069.368842503051;2101.8003289687454;868.8827008353918;946.1720994130136;953.5899563187758;997.4713401897006;1017.3387298256044;16641.750373744402;17436.825631743774;17582.38461653836;17916.552086197687;18069.638607227782;940.2759874896292;945.3571571331423;951.7287573041789;955.2501286490071;990.0594435286507;9386.95306523463;9873.456959867133;9893.159081478156;9913.256505761952;9980.80038399228;267476;284687;522342;526397;531133;58712;58912.7054364734;60277;96252.51873740727;97074.51462742641;979.4612962870393;1006.8338724110587;1013.8073765984586;1080.8811030786608;1092.595739576346;16359.509214723577;16464.259108339913;16475.83524164743;16533.751993719863;16795.748063779298;38115.80942095272;38354.0411489715;39646.60353396429;39907.201855962136;40164.19671606493;55298;58024;58077.709611451675;58257.70871145617;58326.4167358321;8614.3108551317;8621.784455388666;8719.956400217958;8816.911830881609;8899.955500222457;9214.723558293263;11308.943455282671;12031.699207519881;12251.632451026484;12305.753884922073;10719.946400267949;10987.505562249878;10990.725231869268;10998.34009959405;11054.336739795637;10330.225233107396;10430.947845260725;10438.11276041545;10515.421651808918;10578.206634502289;6155.230596175478;7594.392448604209;10519.316244444393;11040.33757974524;11266.380349080551;8370.330373570221;8494.065652778312;8600.655973760979;8660.09069047741;8675.956620216859;9642.662506812228;10186.643467478603;10222.335548189343;10454.895451045391;10476.947615261875 03:31:00 INFO - PROCESS | 13067 | |3;mootools.html;1322.2132830965575;1328.5217321764162;1376.298087975133;1525.5652139140348;1529.6175956010998;7416.777496675095;8127.75616731499;8240.38197135215;8436.957815210932;8460.57697115144;8179;8228.506289622626;8364.58177091146;8438.409311348209;8438.620262088205;2417.383567190364;2422.697162854643;2424.8060155187586;2438.8048956083558;2442.6213936839818;2376.512814872947;2436.5492383908945;2438.6463962725393;2439.731629520751;2444.303373538542;2377.1679912030736;2388.534235824015;2412.5054363855456;2421.1646981791255;2423.5758742220128;2339.6139636959883;2351.6119840226343;2430.453148041694;2444.743301953296;2449.8530088194766;2420.5037967216676;2424.5393375258645;2452.31335226137;2453.546093972603;2456.4841383309526;8493.532855692934;8501;8501.702440414618;8546.914530854674;8589.742307730778;5077.0607437623785;5184.792608295664;5211.661242019294;5219.164933610604;5236.7119808410525;3361.8151001694896;3466.3067386522544;3467.497212904115;3472.461768425898;3490.3193877193958;1138.8234823602354;1139.8347239650286;1151.067635215478;1157.1610582327828;1159.9652010439615;12240.143189976616;12282.38588070593;12289.93855030728;12377.133600647958;12389.566365177176;4541.750203738826;4583;4646.4888862225125;4667.9766601166775;4714.080754252887;9708.368956017977;9731.124198821999;9764.658236961672;9768.609255629695;9793.314467987315;5216.66091704038;5239.580833533309;5239.711815850165;5243.056249874983;5243.056249874983;4358.215521206213;4609.7695115244105;4710.293455981561;4738.19450693383;4846.36997190363;3795;3818.045488627843;3837.175007373428;3877.573466918693;3907.081835768592;1202.8436303280519;1214.678110300771;1215.3437143942172;1235.1354052163522;1244.1850587864963;832.9541875196923;853.7694822397917;879.2702057292432;894.3203165594196;916.876221710074;5800;5857.765689372377;5876.382979787147;5941.881162376728;5954.612950158313;875.094277422877;884.7964968057382;907.3331101640289;920.9493477858648;963.9469829159324;3820.2359528093934;3840.9245411284883;3856.267309211241;3875.2443273561385;3878.8254528545717;10434.843477347846;10473.528691208914;10728.73178170552;10733.624323148651;10754.40850753216;10570.630027948984;10766.300190487593;10815.78368432627;10881.238313317992;10890.945545272381;8051.959740201261;8053.516788992679;8123.9593802031795;8131.796705082302;8135.430519863553;5704.914426283526;5736.19693242938;5770.5095066919785;5782.2194003808945;5821.155932389695;9307.441553506811;9465.148136667733;9470.57382417779;9550.713478595653;9636.662716804878;9175.541222938693;9556.76108097303;9610.855837162588;9678.661246856327;9695.321327507007;6887.862242755217;7433.9256607433235;7600.2779735925;7669.654865531176;7750.341220996053;8034.276915077671;8060.516369017878;8125.106238313899;8186.590670466572;8211.95894020526;6688.331166883273;6760.492963027891;7005.824854378681;7209.531380460253;7280.199178090512;7249.746258881125;7256.346928776436;7301.8299536891245;7307.5980821055355;7328.890066648898;6808.251092379934;6977.511574189758;6987.755428559976;6997.300269972962;7001.649917504003;4879.219324907997;4933.827316043921;4994.325766021686;5042.697438153723;5046.419661738947;4995.125852975787;5012.849614511425;5019.7490125494305;5059.569936555434;5060.569851562658 03:31:00 INFO - PROCESS | 13067 | |4;prototype.html;361.37842910194456;362.2591799769471;364.91606930406004;368.2910397484841;369.5306960160596;6519.641419721914;6561.442277406414;6602.075709400682;6616.867662646744;6653.9667301663485;6644.9700296454;6682.331766823315;6690.397864192221;6694.665266736668;6694.832629184273;5048.520390562909;5085.110105731501;5087.720175390352;5093.847184584469;5103.56619687327;5083.110455670261;5091.058154241458;5098.133317336044;5102.770375333119;5104.923426148593;5048.394192696863;5053.014662140884;5057.393112826466;5061.3420255366755;5064.56951159152;4934.654574179791;5031.572316353115;5033.974830125862;5044.066847633163;5048.848534543951;4389.561043895616;4415.470143582758;4415.779211039435;4416.933745993812;4434.778261086933;6375.043743438475;6376.043593460971;6387.808365749035;6404.327545607737;6435.066915297302;5746.741396637161;5833.4749872511675;5903.645781253139;5914.053751399755;5932.080527518198;6892.689828957709;6935.271796461399;7000.50996430245;7034.3669069783455;7055.188653304885;4952.925706114411;4953.405591329028;4955.628327875424;4969.950300496985;4971.27916452116;7272.236415176383;7362.631868406612;7363.77908662741;7365.189829118793;7381.88927166093;4910.950890491121;5071.264666623319;5098.337216161949;5109.6678715883345;5119.48805119485;5160.380754309507;5184.040952423738;5192.350956130484;5198.792048318025;5204.089284375219;5910.054391297372;5924.674142922181;5936.910946335722;5939.70301484924;5942.584019118706;7094.219635840053;7122.857542849114;7125.144982602121;7125.92874071263;7132.28677132293;1800.0009994452942;1828.8902665840092;1829.8563397876328;1830.1581272614746;1830.3776715916385;1126.571902676994;1168.1764356128908;1200.0279773383588;1214.247166756599;1225.9080568957186;6643.534952553275;6892.379685828299;6897.862042759117;6925.238223795379;6939.375456208965;7353.0441042664115;7357.0803649543805;7361.190269070398;7370.041894553674;7379.372753315921;6872.69072891721;6913.446924246048;6936.306369363124;6936.514443988974;6944.756933507303;3886.378179491268;3925.8822235332987;3958.0698535844053;3959.0102474381406;3982.123932734794;7618;7690.423218258541;7693.769186924401;7693.922850800893;7708.9229107709325;7485.363744081814;7497.437692173109;7505.812354691067;7554;7554.131274903457;7634.4655874088285;7636.160022397532;7666.156722760492;7675.846483070419;7689.653965571562;7197.100362454693;7337.119545654556;7383.224761400191;7406.814829629302;7407;7248.130224373109;7268.41852651776;7270.927290727025;7278.563286202845;7285.562866227831;7533.322001019935;7654.578998155155;7680.577568233801;7686.961565192139;7716;5093.6179786516905;5143.819966301162;5145.588352931682;5149.459306772735;5157.742112894265;7103.289671033062;7287.234840341688;7309.853802924018;7311.780646580611;7361.668724907285;7134.750283740044;7159;7168.569885806868;7170.533915295698;7172.856542869009;7059.717611295696;7068;7101.8579628406105;7106.395956343768;7120.537165084253;6879.484038697218;6912.447004239548;6965.5124141309625;6967.233604303624;6981.162260528769;7034.1910680270375;7098.609576473344;7152.821179470555;7172.928270717226;7174.641267936478;6683.565568238049;6868.107146070979;6952.826179345557;6959.61722105289;7025.227225005143 03:31:00 INFO - PROCESS | 13067 | |5;yui.html;691.1050190003945;701.5650296815975;709.4041005555334;730.3171534615132;734.3354264390725;14103.929480352597;14187.78718319226;14214.076085054465;14238.430462781489;14377.209253491066;13721.313934303269;13994.370253338599;14049.086809357384;14059.578212653636;14116.57650270491;603.7886739641124;614.1463365921372;614.2322097378277;616.2697203813473;617.5275913925827;613.4632196827775;615.3415845045803;616.3866952382385;616.7810427298311;620.1008537620446;852.3862818770506;854.9658013679446;855.3670283989865;860.4407135362002;861.4013260783757;855.3328403844948;855.8117214212863;857.4469467193687;858.7295002074358;859.055039456599;625.9217597800275;627.8085184018872;629.326620516048;630.8202162383744;631.6589041917359;13478.460861565525;13602.047856650039;13609.455621775118;13634.250116243602;13712.588622341345;13571.864281357257;13847.16916984974;13916.58250252494;13931.791023134661;13992.650183745385;11646.818476256947;11853.348065856375;11886.108541859396;12091.879081209163;12093.45579448927;3868.6905047596124;3904.082540602956;3915.3735402335774;3942.2115576884453;4074.5721699221453;60530.092048619306;60880.391196088356;61121.38878611202;61379.693101534656;61398;10384.844227336596;10504.159667226604;10584.735381615521;10800.297980631234;10862.131029517619;18485.907570462332;18524.907375463037;18631.534211644546;18694.81305186958;18765.530861728294;7879.527228366316;8099.190080991972;8173.836523269501;8229.218224268805;8310.916890831135;4974.7263900485095;5007.524285192901;5033.5721463676;5095.745212739348;5179.093658609729;3445.3798316303305;3453.4819777033645;3468.7745296555645;3481.286336301103;3487.3548393547276;594.485769809112;598.2790737161797;598.8892054969845;599.7990673124465;602.8312072619674;654.4698793976894;663.626700046685;704.9506534542635;746.3432179681954;754.705664790732;9573.473458959825;9844.458554779412;9910.44419083308;9966.601335946481;9968.302218844756;618.227215980025;664.455146779636;710.0308079471484;735.6910097758954;761.7372006657695;4422.270325396338;4651;4698.976505117521;4851.126797176542;4868.683535570177;56916;63567.364326356146;64120.35879641237;64206.678966604864;64591;49368.25947610789;49735;50022.749886250334;50497;51118.48881511212;48128.5187148131;48635.27047094297;52085;54242.18636720452;54976.17535736967;10265.384076955406;10324.277300588887;10381.584736610452;10473.633422830164;10594.364338139736;37022.62977370192;38414.423783643826;39245.60754392534;40255.59744402519;40736.79631601823;45530.54469455263;49781.253281201534;50359.74820126023;53038.73480632572;53314.66524496754;11438.714032149262;11561.248518846249;11640.243384180001;12004.819927700917;12052.216605920587;13816.309184540934;14039.298035098409;14210.644733881736;14211.360488778237;14707.632309192355;12640.620781376574;13017.088803783645;13419.597412077654;13490.52783152585;13865.376058077612;13095.279759613313;13114.950803935471;13262.27057511846;13549.187048777105;13671.453141874214;12309.384530773246;12542.310172940575;12988.935055324662;13353.866461335263;13718.45126194941;11230.719232019264;11532.94233528827;11533.250338727956;11538.59614913474;11968.341741204318;11243.212975091665;11385;11416.200865939305;11448.484818183035;11490 03:31:00 INFO - PROCESS | 13067 | __end_tp_report 03:31:00 INFO - PROCESS | 13067 | __start_cc_report 03:31:00 INFO - PROCESS | 13067 | _x_x_mozilla_cycle_collect,325 03:31:00 INFO - PROCESS | 13067 | __end_cc_report 03:31:00 INFO - PROCESS | 13067 | __startTimestamp1464431460961__endTimestamp 03:31:00 INFO - PROCESS | 13067 | 03:31:00 INFO - PROCESS | 13067 | ------- Summary: start ------- 03:31:00 INFO - PROCESS | 13067 | Number of tests: 6 03:31:00 INFO - PROCESS | 13067 | 03:31:00 INFO - PROCESS | 13067 | [#0] dojo.html Cycles:165 Average:5672.56 Median:5926.50 stddev:621.31 (10.5%) stddev-sans-first:596.72 03:31:00 INFO - PROCESS | 13067 | Values: 3384.4 3414.8 3442.2 3465.9 3482.7 5721.7 5740.5 5790.1 5794.0 5807.7 5713.4 5777.2 5807.5 5813.1 5831.2 5156.6 5204.7 5267.7 5269.6 5283.8 5070.4 5294.2 5370.2 5376.4 5411.1 5172.4 5186.5 5197.9 5263.6 5279.1 5118.2 5213.0 5218.7 5223.1 5294.6 5133.2 5204.5 5220.9 5221.8 5252.1 5474.2 5498.4 5602.5 5627.8 5641.5 5940.6 5940.7 5946.2 5953.0 6045.8 6004.8 6010.8 6019.5 6031.0 6040.1 5600.2 5607.7 5629.8 5633.7 5645.7 6125.1 6140.4 6142.5 6146.6 6155.4 5894.1 5926.5 5931.1 5931.6 5932.8 6109.5 6195.0 6205.3 6205.7 6223.3 5959.5 5963.2 5977.3 5980.6 6044.6 5947.3 5948.2 5972.2 6024.3 6029.9 4580.1 4610.9 4636.8 4646.0 4669.2 4147.5 4147.6 4154.3 4163.1 4193.4 5864.2 5889.3 5913.8 5968.8 5975.0 6005.2 6023.1 6079.7 6102.2 6116.2 5918.2 5950.0 5976.3 5984.0 6020.2 5200.9 5208.4 5280.6 5318.5 5325.5 6301.2 6348.0 6368.4 6368.7 6380.6 6146.5 6171.0 6185.7 6192.3 6194.2 6258.4 6342.8 6383.4 6398.6 6437.0 6012.2 6013.1 6013.5 6030.4 6034.0 6054.4 6082.5 6119.1 6127.3 6135.1 5899.0 5931.5 5972.2 5980.5 5982.7 5900.2 5930.0 5935.7 5946.3 5967.5 5729.3 5849.2 5856.4 5856.8 5867.0 5781.6 5924.0 5942.1 6019.2 6060.4 5886.1 5898.1 5901.5 5942.1 5949.4 03:31:00 INFO - PROCESS | 13067 | 03:31:00 INFO - PROCESS | 13067 | [#1] ext.html Cycles:180 Average:54975.99 Median:34715.07 stddev:119398.96 (343.9%) stddev-sans-first:119664.10 03:31:00 INFO - PROCESS | 13067 | Values: 598.1 636.8 652.5 659.2 684.4 32474.7 34003.3 34018.3 34101.1 34219.7 34705.3 34724.8 35099.3 35141.8 35208.0 8427.9 8562.6 8587.8 8614.8 8631.6 8440.3 8695.6 8695.9 8703.2 8735.2 8663.0 8703.8 8772.3 8774.0 8775.8 8699.7 8718.5 8737.3 8763.0 8763.9 8687.2 8745.5 8784.9 8798.2 8803.1 32739.5 33380.3 33411.8 33425.5 33491.5 3570.6 3578.4 3609.3 3636.7 3743.3 26648.0 26760.6 26797.7 26893.0 27580.9 4416.0 4440.8 4470.0 4518.7 4550.6 285806.0 288164.0 288938.0 290804.0 292731.0 33202.2 33897.5 49072.8 49225.5 49257.0 32914.5 32947.7 32967.3 33046.8 33129.0 13622.7 13708.1 13780.7 13818.9 13846.8 10543.6 10616.0 10626.8 10640.6 10668.7 8249.5 8344.1 8349.9 8354.0 8418.2 3347.1 3440.5 3461.7 3482.3 3491.6 1043.8 1058.4 1091.5 1098.6 1182.9 28823.4 28845.7 29071.7 29074.9 29369.0 1088.8 1121.2 1121.8 1129.9 1150.2 15276.5 15360.2 15366.0 15450.2 15582.5 478091.0 514473.0 523304.0 524061.0 799924.0 47465.3 48957.8 49102.0 49214.3 49382.8 1310.4 1314.1 1322.0 1326.2 1342.8 29613.6 29617.9 29881.7 30234.2 30415.8 44215.8 44223.8 44433.1 44524.6 44570.6 417850.0 418712.0 420130.0 420403.0 424511.0 27290.7 38644.4 39228.0 39473.6 39535.2 37934.4 38400.6 38601.6 38881.8 38896.8 32958.8 33297.0 33654.5 33768.0 33800.2 33523.5 33699.5 33866.2 33902.7 36233.8 34815.1 35150.5 35299.0 35382.3 37709.4 31613.0 32234.8 32273.2 32501.7 34296.8 25072.7 25735.5 25812.1 25973.5 26191.9 03:31:00 INFO - PROCESS | 13067 | 03:31:00 INFO - PROCESS | 13067 | [#2] jquery.html Cycles:180 Average:25864.87 Median:403.17 stddev:73281.22 (18176.2%) stddev-sans-first:73461.83 03:31:00 INFO - PROCESS | 13067 | Values: 391.6 396.7 402.5 403.8 416.9 17512.7 17713.2 18226.3 18234.4 18321.8 15277.0 15787.1 15906.5 15914.4 15939.4 5045.5 5251.3 5261.1 5286.8 5298.7 5152.6 5226.7 5229.5 5237.1 5238.6 5236.2 5430.5 5695.2 5699.2 5719.0 5610.0 5644.2 5661.5 5876.6 6243.5 5575.5 5581.2 5615.3 5632.5 5661.0 13609.9 14818.7 20019.7 20580.6 21419.5 2357.3 2441.4 2453.5 2519.0 2597.5 10444.6 10618.2 10648.8 10721.7 10935.4 1972.0 2012.4 2081.3 2082.3 2092.6 73322.0 74572.0 75212.2 75977.6 76911.6 10560.6 10619.8 10665.1 10888.4 10955.6 15008.9 15025.9 15046.9 15079.3 15133.6 6794.9 7223.7 7313.8 7466.4 7555.5 7050.2 7095.5 7296.0 7517.4 7541.4 4613.3 4689.9 4732.2 4732.4 4781.4 1961.2 2036.3 2054.8 2069.4 2101.8 868.9 946.2 953.6 997.5 1017.3 16641.8 17436.8 17582.4 17916.6 18069.6 940.3 945.4 951.7 955.3 990.1 9387.0 9873.5 9893.2 9913.3 9980.8 267476.0 284687.0 522342.0 526397.0 531133.0 58712.0 58912.7 60277.0 96252.5 97074.5 979.5 1006.8 1013.8 1080.9 1092.6 16359.5 16464.3 16475.8 16533.8 16795.7 38115.8 38354.0 39646.6 39907.2 40164.2 55298.0 58024.0 58077.7 58257.7 58326.4 8614.3 8621.8 8720.0 8816.9 8900.0 9214.7 11308.9 12031.7 12251.6 12305.8 10719.9 10987.5 10990.7 10998.3 11054.3 10330.2 10430.9 10438.1 10515.4 10578.2 6155.2 7594.4 10519.3 11040.3 11266.4 8370.3 8494.1 8600.7 8660.1 8676.0 9642.7 10186.6 10222.3 10454.9 10476.9 03:31:00 INFO - PROCESS | 13067 | 03:31:00 INFO - PROCESS | 13067 | [#3] mootools.html Cycles:180 Average:5628.37 Median:5130.93 stddev:3152.38 (61.4%) stddev-sans-first:3144.61 03:31:00 INFO - PROCESS | 13067 | Values: 1322.2 1328.5 1376.3 1525.6 1529.6 7416.8 8127.8 8240.4 8437.0 8460.6 8179.0 8228.5 8364.6 8438.4 8438.6 2417.4 2422.7 2424.8 2438.8 2442.6 2376.5 2436.5 2438.6 2439.7 2444.3 2377.2 2388.5 2412.5 2421.2 2423.6 2339.6 2351.6 2430.5 2444.7 2449.9 2420.5 2424.5 2452.3 2453.5 2456.5 8493.5 8501.0 8501.7 8546.9 8589.7 5077.1 5184.8 5211.7 5219.2 5236.7 3361.8 3466.3 3467.5 3472.5 3490.3 1138.8 1139.8 1151.1 1157.2 1160.0 12240.1 12282.4 12289.9 12377.1 12389.6 4541.8 4583.0 4646.5 4668.0 4714.1 9708.4 9731.1 9764.7 9768.6 9793.3 5216.7 5239.6 5239.7 5243.1 5243.1 4358.2 4609.8 4710.3 4738.2 4846.4 3795.0 3818.0 3837.2 3877.6 3907.1 1202.8 1214.7 1215.3 1235.1 1244.2 833.0 853.8 879.3 894.3 916.9 5800.0 5857.8 5876.4 5941.9 5954.6 875.1 884.8 907.3 920.9 963.9 3820.2 3840.9 3856.3 3875.2 3878.8 10434.8 10473.5 10728.7 10733.6 10754.4 10570.6 10766.3 10815.8 10881.2 10890.9 8052.0 8053.5 8124.0 8131.8 8135.4 5704.9 5736.2 5770.5 5782.2 5821.2 9307.4 9465.1 9470.6 9550.7 9636.7 9175.5 9556.8 9610.9 9678.7 9695.3 6887.9 7433.9 7600.3 7669.7 7750.3 8034.3 8060.5 8125.1 8186.6 8212.0 6688.3 6760.5 7005.8 7209.5 7280.2 7249.7 7256.3 7301.8 7307.6 7328.9 6808.3 6977.5 6987.8 6997.3 7001.6 4879.2 4933.8 4994.3 5042.7 5046.4 4995.1 5012.8 5019.7 5059.6 5060.6 03:31:00 INFO - PROCESS | 13067 | 03:31:00 INFO - PROCESS | 13067 | [#4] prototype.html Cycles:180 Average:5945.10 Median:6694.75 stddev:1797.01 (26.8%) stddev-sans-first:1752.50 03:31:00 INFO - PROCESS | 13067 | Values: 361.4 362.3 364.9 368.3 369.5 6519.6 6561.4 6602.1 6616.9 6654.0 6645.0 6682.3 6690.4 6694.7 6694.8 5048.5 5085.1 5087.7 5093.8 5103.6 5083.1 5091.1 5098.1 5102.8 5104.9 5048.4 5053.0 5057.4 5061.3 5064.6 4934.7 5031.6 5034.0 5044.1 5048.8 4389.6 4415.5 4415.8 4416.9 4434.8 6375.0 6376.0 6387.8 6404.3 6435.1 5746.7 5833.5 5903.6 5914.1 5932.1 6892.7 6935.3 7000.5 7034.4 7055.2 4952.9 4953.4 4955.6 4970.0 4971.3 7272.2 7362.6 7363.8 7365.2 7381.9 4911.0 5071.3 5098.3 5109.7 5119.5 5160.4 5184.0 5192.4 5198.8 5204.1 5910.1 5924.7 5936.9 5939.7 5942.6 7094.2 7122.9 7125.1 7125.9 7132.3 1800.0 1828.9 1829.9 1830.2 1830.4 1126.6 1168.2 1200.0 1214.2 1225.9 6643.5 6892.4 6897.9 6925.2 6939.4 7353.0 7357.1 7361.2 7370.0 7379.4 6872.7 6913.4 6936.3 6936.5 6944.8 3886.4 3925.9 3958.1 3959.0 3982.1 7618.0 7690.4 7693.8 7693.9 7708.9 7485.4 7497.4 7505.8 7554.0 7554.1 7634.5 7636.2 7666.2 7675.8 7689.7 7197.1 7337.1 7383.2 7406.8 7407.0 7248.1 7268.4 7270.9 7278.6 7285.6 7533.3 7654.6 7680.6 7687.0 7716.0 5093.6 5143.8 5145.6 5149.5 5157.7 7103.3 7287.2 7309.9 7311.8 7361.7 7134.8 7159.0 7168.6 7170.5 7172.9 7059.7 7068.0 7101.9 7106.4 7120.5 6879.5 6912.4 6965.5 6967.2 6981.2 7034.2 7098.6 7152.8 7172.9 7174.6 6683.6 6868.1 6952.8 6959.6 7025.2 03:31:00 INFO - PROCESS | 13067 | 03:31:00 INFO - PROCESS | 13067 | [#5] yui.html Cycles:180 Average:15339.76 Median:24976.41 stddev:17780.91 (71.2%) stddev-sans-first:17796.76 03:31:00 INFO - PROCESS | 13067 | Values: 691.1 701.6 709.4 730.3 734.3 14103.9 14187.8 14214.1 14238.4 14377.2 13721.3 13994.4 14049.1 14059.6 14116.6 603.8 614.1 614.2 616.3 617.5 613.5 615.3 616.4 616.8 620.1 852.4 855.0 855.4 860.4 861.4 855.3 855.8 857.4 858.7 859.1 625.9 627.8 629.3 630.8 631.7 13478.5 13602.0 13609.5 13634.3 13712.6 13571.9 13847.2 13916.6 13931.8 13992.7 11646.8 11853.3 11886.1 12091.9 12093.5 3868.7 3904.1 3915.4 3942.2 4074.6 60530.1 60880.4 61121.4 61379.7 61398.0 10384.8 10504.2 10584.7 10800.3 10862.1 18485.9 18524.9 18631.5 18694.8 18765.5 7879.5 8099.2 8173.8 8229.2 8310.9 4974.7 5007.5 5033.6 5095.7 5179.1 3445.4 3453.5 3468.8 3481.3 3487.4 594.5 598.3 598.9 599.8 602.8 654.5 663.6 705.0 746.3 754.7 9573.5 9844.5 9910.4 9966.6 9968.3 618.2 664.5 710.0 735.7 761.7 4422.3 4651.0 4699.0 4851.1 4868.7 56916.0 63567.4 64120.4 64206.7 64591.0 49368.3 49735.0 50022.7 50497.0 51118.5 48128.5 48635.3 52085.0 54242.2 54976.2 10265.4 10324.3 10381.6 10473.6 10594.4 37022.6 38414.4 39245.6 40255.6 40736.8 45530.5 49781.3 50359.7 53038.7 53314.7 11438.7 11561.2 11640.2 12004.8 12052.2 13816.3 14039.3 14210.6 14211.4 14707.6 12640.6 13017.1 13419.6 13490.5 13865.4 13095.3 13115.0 13262.3 13549.2 13671.5 12309.4 12542.3 12988.9 13353.9 13718.5 11230.7 11532.9 11533.3 11538.6 11968.3 11243.2 11385.0 11416.2 11448.5 11490.0 03:31:00 INFO - PROCESS | 13067 | -------- Summary: end -------- 03:31:00 INFO - PROCESS | 13067 | 03:31:01 INFO - TEST-INFO | 13067: exit 0 03:31:01 INFO - TEST-OK | dromaeo_css | took 1108333ms 03:31:01 INFO - TEST-START | kraken 03:31:01 INFO - operating with platform_type : linux_ 03:31:01 INFO - Initialising browser for kraken test... 03:31:01 INFO - TEST-INFO | started process 13312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKHQE4D/profile http://localhost:56665/getInfo.html) 03:31:04 INFO - PROCESS | 13312 | 03:31:04 INFO - PROCESS | 13312 | (process:13391): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:31:05 INFO - PROCESS | 13312 | __metrics Screen width/height:1600/1200 03:31:05 INFO - PROCESS | 13312 | colorDepth:24 03:31:05 INFO - PROCESS | 13312 | Browser inner width/height: 1024/697 03:31:05 INFO - PROCESS | 13312 | __metrics 03:31:06 ERROR - PROCESS | 13312 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 03:31:07 INFO - TEST-INFO | 13312: exit 0 03:31:07 INFO - Browser initialized. 03:31:07 INFO - Running cycle 1/1 for kraken test... 03:31:07 INFO - TEST-INFO | started process 13442 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKHQE4D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:08 INFO - PROCESS | 13442 | 03:31:08 INFO - PROCESS | 13442 | (process:13507): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:31:18 INFO - PROCESS | 13442 | RSS: Main: 152174592 03:31:18 INFO - PROCESS | 13442 | 03:31:21 INFO - PROCESS | 13442 | Cycle 1(1): loaded http://localhost:56665/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56665/tests/kraken/driver.html?testName=audio-beat-detection) 03:31:22 INFO - PROCESS | 13442 | RSS: Main: 157417472 03:31:22 INFO - PROCESS | 13442 | 03:31:24 INFO - PROCESS | 13442 | Cycle 1(1): loaded http://localhost:56665/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56665/tests/kraken/driver.html?testName=audio-dft) 03:31:25 INFO - PROCESS | 13442 | RSS: Main: 157663232 03:31:25 INFO - PROCESS | 13442 | 03:31:28 INFO - PROCESS | 13442 | Cycle 1(1): loaded http://localhost:56665/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56665/tests/kraken/driver.html?testName=audio-fft) 03:31:28 INFO - PROCESS | 13442 | RSS: Main: 157278208 03:31:28 INFO - PROCESS | 13442 | 03:31:31 INFO - PROCESS | 13442 | Cycle 1(1): loaded http://localhost:56665/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56665/tests/kraken/driver.html?testName=audio-oscillator) 03:31:31 INFO - PROCESS | 13442 | RSS: Main: 157396992 03:31:31 INFO - PROCESS | 13442 | 03:31:33 INFO - PROCESS | 13442 | Cycle 1(1): loaded http://localhost:56665/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56665/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:31:34 INFO - PROCESS | 13442 | RSS: Main: 157093888 03:31:34 INFO - PROCESS | 13442 | 03:31:37 INFO - PROCESS | 13442 | Cycle 1(1): loaded http://localhost:56665/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56665/tests/kraken/driver.html?testName=imaging-darkroom) 03:31:38 INFO - PROCESS | 13442 | RSS: Main: 157253632 03:31:38 INFO - PROCESS | 13442 | 03:31:41 INFO - PROCESS | 13442 | Cycle 1(1): loaded http://localhost:56665/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56665/tests/kraken/driver.html?testName=imaging-desaturate) 03:31:42 INFO - PROCESS | 13442 | RSS: Main: 157106176 03:31:42 INFO - PROCESS | 13442 | 03:31:44 INFO - PROCESS | 13442 | Cycle 1(1): loaded http://localhost:56665/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56665/tests/kraken/driver.html?testName=json-parse-financial) 03:31:45 INFO - PROCESS | 13442 | RSS: Main: 157011968 03:31:45 INFO - PROCESS | 13442 | 03:31:46 INFO - PROCESS | 13442 | Cycle 1(1): loaded http://localhost:56665/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56665/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:31:47 INFO - PROCESS | 13442 | RSS: Main: 157036544 03:31:47 INFO - PROCESS | 13442 | 03:31:49 INFO - PROCESS | 13442 | Cycle 1(1): loaded http://localhost:56665/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56665/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:31:49 INFO - PROCESS | 13442 | RSS: Main: 157536256 03:31:49 INFO - PROCESS | 13442 | 03:31:51 INFO - PROCESS | 13442 | Cycle 1(1): loaded http://localhost:56665/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56665/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:31:52 INFO - PROCESS | 13442 | RSS: Main: 157843456 03:31:52 INFO - PROCESS | 13442 | 03:31:55 INFO - PROCESS | 13442 | Cycle 1(1): loaded http://localhost:56665/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56665/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:31:55 INFO - PROCESS | 13442 | RSS: Main: 158543872 03:31:55 INFO - PROCESS | 13442 | 03:31:58 INFO - PROCESS | 13442 | Cycle 1(1): loaded http://localhost:56665/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56665/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:31:59 INFO - PROCESS | 13442 | RSS: Main: 158130176 03:31:59 INFO - PROCESS | 13442 | 03:32:00 INFO - PROCESS | 13442 | Cycle 1(1): loaded http://localhost:56665/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56665/tests/kraken/driver.html?testName=ai-astar) 03:32:00 INFO - PROCESS | 13442 | RSS: Main: 159518720 03:32:00 INFO - PROCESS | 13442 | 03:32:00 INFO - PROCESS | 13442 | __start_tp_report 03:32:00 INFO - PROCESS | 13442 | _x_x_mozilla_page_load 03:32:00 INFO - PROCESS | 13442 | _x_x_mozilla_page_load_details 03:32:00 INFO - PROCESS | 13442 | |i|pagename|runs| 03:32:00 INFO - PROCESS | 13442 | |0;ai-astar;107;112;106;110;113;117;101;110;112;112 03:32:00 INFO - PROCESS | 13442 | |1;audio-beat-detection;152;135;155;179;131;165;160;128;178;128 03:32:00 INFO - PROCESS | 13442 | |2;audio-dft;162;162;170;163;162;164;163;163;162;163 03:32:00 INFO - PROCESS | 13442 | |3;audio-fft;72;76;75;170;76;77;76;85;168;77 03:32:00 INFO - PROCESS | 13442 | |4;audio-oscillator;91;92;162;91;92;92;148;93;91;152 03:32:00 INFO - PROCESS | 13442 | |5;imaging-gaussian-blur;118;116;118;117;117;117;117;117;117;117 03:32:00 INFO - PROCESS | 13442 | |6;imaging-darkroom;146;147;148;148;147;148;147;147;148;147 03:32:00 INFO - PROCESS | 13442 | |7;imaging-desaturate;96;95;94;97;96;95;95;95;95;95 03:32:00 INFO - PROCESS | 13442 | |8;json-parse-financial;54;55;54;58;55;55;54;77;54;57 03:32:00 INFO - PROCESS | 13442 | |9;json-stringify-tinderbox;57;58;57;58;57;57;58;58;58;59 03:32:00 INFO - PROCESS | 13442 | |10;stanford-crypto-aes;74;73;72;73;75;75;77;74;75;74 03:32:00 INFO - PROCESS | 13442 | |11;stanford-crypto-ccm;115;114;114;114;116;122;117;113;139;131 03:32:00 INFO - PROCESS | 13442 | |12;stanford-crypto-pbkdf2;162;158;167;158;158;167;160;157;159;159 03:32:00 INFO - PROCESS | 13442 | |13;stanford-crypto-sha256-iterative;66;67;67;76;68;64;67;65;65;64 03:32:00 INFO - PROCESS | 13442 | __end_tp_report 03:32:00 INFO - PROCESS | 13442 | __start_cc_report 03:32:00 INFO - PROCESS | 13442 | _x_x_mozilla_cycle_collect,853 03:32:00 INFO - PROCESS | 13442 | __end_cc_report 03:32:00 INFO - PROCESS | 13442 | __startTimestamp1464431520934__endTimestamp 03:32:00 INFO - PROCESS | 13442 | 03:32:00 INFO - PROCESS | 13442 | ------- Summary: start ------- 03:32:00 INFO - PROCESS | 13442 | Number of tests: 14 03:32:00 INFO - PROCESS | 13442 | 03:32:00 INFO - PROCESS | 13442 | [#0] ai-astar Cycles:10 Average:110.00 Median:112.00 stddev:4.42 (3.9%) stddev-sans-first:4.56 03:32:00 INFO - PROCESS | 13442 | Values: 107.0 112.0 106.0 110.0 113.0 117.0 101.0 110.0 112.0 112.0 03:32:00 INFO - PROCESS | 13442 | 03:32:00 INFO - PROCESS | 13442 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:157.50 stddev:19.78 (12.6%) stddev-sans-first:20.98 03:32:00 INFO - PROCESS | 13442 | Values: 152.0 135.0 155.0 179.0 131.0 165.0 160.0 128.0 178.0 128.0 03:32:00 INFO - PROCESS | 13442 | 03:32:00 INFO - PROCESS | 13442 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.41 (1.5%) stddev-sans-first:2.51 03:32:00 INFO - PROCESS | 13442 | Values: 162.0 162.0 170.0 163.0 162.0 164.0 163.0 163.0 162.0 163.0 03:32:00 INFO - PROCESS | 13442 | 03:32:00 INFO - PROCESS | 13442 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.00 stddev:39.04 (51.4%) stddev-sans-first:40.49 03:32:00 INFO - PROCESS | 13442 | Values: 72.0 76.0 75.0 170.0 76.0 77.0 76.0 85.0 168.0 77.0 03:32:00 INFO - PROCESS | 13442 | 03:32:00 INFO - PROCESS | 13442 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:91.50 stddev:30.28 (33.1%) stddev-sans-first:31.30 03:32:00 INFO - PROCESS | 13442 | Values: 91.0 92.0 162.0 91.0 92.0 92.0 148.0 93.0 91.0 152.0 03:32:00 INFO - PROCESS | 13442 | 03:32:00 INFO - PROCESS | 13442 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 03:32:00 INFO - PROCESS | 13442 | Values: 118.0 116.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 03:32:00 INFO - PROCESS | 13442 | 03:32:00 INFO - PROCESS | 13442 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.53 03:32:00 INFO - PROCESS | 13442 | Values: 146.0 147.0 148.0 148.0 147.0 148.0 147.0 147.0 148.0 147.0 03:32:00 INFO - PROCESS | 13442 | 03:32:00 INFO - PROCESS | 13442 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 03:32:00 INFO - PROCESS | 13442 | Values: 96.0 95.0 94.0 97.0 96.0 95.0 95.0 95.0 95.0 95.0 03:32:00 INFO - PROCESS | 13442 | 03:32:00 INFO - PROCESS | 13442 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:55.00 stddev:7.06 (12.8%) stddev-sans-first:7.38 03:32:00 INFO - PROCESS | 13442 | Values: 54.0 55.0 54.0 58.0 55.0 55.0 54.0 77.0 54.0 57.0 03:32:00 INFO - PROCESS | 13442 | 03:32:00 INFO - PROCESS | 13442 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.67 (1.2%) stddev-sans-first:0.67 03:32:00 INFO - PROCESS | 13442 | Values: 57.0 58.0 57.0 58.0 57.0 57.0 58.0 58.0 58.0 59.0 03:32:00 INFO - PROCESS | 13442 | 03:32:00 INFO - PROCESS | 13442 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:74.50 stddev:1.40 (1.9%) stddev-sans-first:1.48 03:32:00 INFO - PROCESS | 13442 | Values: 74.0 73.0 72.0 73.0 75.0 75.0 77.0 74.0 75.0 74.0 03:32:00 INFO - PROCESS | 13442 | 03:32:00 INFO - PROCESS | 13442 | [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:116.50 stddev:8.76 (7.5%) stddev-sans-first:9.14 03:32:00 INFO - PROCESS | 13442 | Values: 115.0 114.0 114.0 114.0 116.0 122.0 117.0 113.0 139.0 131.0 03:32:00 INFO - PROCESS | 13442 | 03:32:00 INFO - PROCESS | 13442 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:159.50 stddev:3.69 (2.3%) stddev-sans-first:3.87 03:32:00 INFO - PROCESS | 13442 | Values: 162.0 158.0 167.0 158.0 158.0 167.0 160.0 157.0 159.0 159.0 03:32:00 INFO - PROCESS | 13442 | 03:32:00 INFO - PROCESS | 13442 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:3.48 (5.2%) stddev-sans-first:3.67 03:32:00 INFO - PROCESS | 13442 | Values: 66.0 67.0 67.0 76.0 68.0 64.0 67.0 65.0 65.0 64.0 03:32:00 INFO - PROCESS | 13442 | -------- Summary: end -------- 03:32:00 INFO - PROCESS | 13442 | 03:32:01 INFO - TEST-INFO | 13442: exit 0 03:32:01 INFO - TEST-OK | kraken | took 60143ms 03:32:01 INFO - SUITE-END | took 1168s 03:32:02 INFO - Completed test suite (00:19:28) 03:32:02 INFO - javascript benchmark 03:32:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3384.4077286474867, 3414.8463319150637, 3442.156671615455, 3465.9306813863714, 3482.7213822894173, 5721.656700597967, 5740.454656807602, 5790.131480277961, 5794.0, 5807.73865176067, 5713.428657134285, 5777.220075289834, 5807.535397168227, 5813.098969659699, 5831.2419385479825, 5156.561692256163, 5204.661696989683, 5267.683938963655, 5269.6311258211945, 5283.788648454057, 5070.442251352349, 5294.1529355303155, 5370.248165256867, 5376.381716102659, 5411.134218525037, 5172.379314482268, 5186.455422180673, 5197.948020519784, 5263.631545791777, 5279.076161671692, 5118.232265160219, 5212.9739351303, 5218.712970786605, 5223.138182199932, 5294.629375943686, 5133.178691409394, 5204.479552044765, 5220.921686174673, 5221.791128354861, 5252.107141785906, 5474.178873169017, 5498.395176530578, 5602.523785478239, 5627.831165065055, 5641.464060914206, 5940.554458415593, 5940.673262970535, 5946.167536544887, 5952.9702351488395, 6045.788397406113, 6004.78983235589, 6010.75956961721, 6019.518438524951, 6030.96984515079, 6040.12418199363, 5600.215969764236, 5607.7476513556985, 5629.774809007635, 5633.746481408305, 5645.661260324394, 6125.081237814364, 6140.3552626974415, 6142.508599312045, 6146.631202127886, 6155.415235552616, 5894.086416605433, 5926.496247818897, 5931.139984702194, 5931.58478906481, 5932.762689492458, 6109.495762817221, 6195.021057090846, 6205.317415084337, 6205.689715514206, 6223.253209614875, 5959.4934430573885, 5963.224780778471, 5977.342492325841, 5980.611260268069, 6044.637321760709, 5947.31605865331, 5948.167256584082, 5972.193753843176, 6024.337322894478, 6029.909551356734, 4580.129775342674, 4610.861674149781, 4636.768161591907, 4645.953540464619, 4669.2062349400685, 4147.543770185277, 4147.6267135957305, 4154.252234597801, 4163.10493243948, 4193.412922190834, 5864.237649105674, 5889.293284805765, 5913.76344946206, 5968.820935371946, 5975.0, 6005.159277701126, 6023.096535519707, 6079.726412311456, 6102.237220347457, 6116.244470650255, 5918.23063001807, 5950.0, 5976.342602313742, 5984.0, 6020.247469066367, 5200.869978250498, 5208.427073021964, 5280.577553795687, 5318.494742999409, 5325.547328477122, 6301.180846490019, 6347.96826015867, 6368.395002474757, 6368.713407896656, 6380.617162970237, 6146.5390095743, 6171.0, 6185.6907154641185, 6192.2569291683485, 6194.163787888578, 6258.43674069336, 6342.841428964312, 6383.39357761012, 6398.616083035033, 6437.034444833313, 6012.158297838394, 6013.098035294741, 6013.5189184865985, 6030.396960303934, 6033.9698301508215, 6054.390423955979, 6082.513398927987, 6119.051547010221, 6127.264728232462, 6135.14108024868, 5899.0, 5931.525477961666, 5972.193753843176, 5980.491658209101, 5982.670953097621, 5900.232969713909, 5929.970350148395, 5935.673537955281, 5946.256717910262, 5967.46292833647, 5729.255196824386, 5849.210356601974, 5856.385079566584, 5856.7950121747235, 5867.0, 5781.595288329945, 5923.970380148072, 5942.10868369748, 6019.157317975574, 6060.424259695322, 5886.117082437669, 5898.144769008555, 5901.498372638202, 5942.078977758454, 5949.3753155918], "value": 5632.5425542275125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.1476396135506, 636.7834936121719, 652.4714980865498, 659.228702418171, 684.3601232847291, 32474.67525324746, 34003.31993360131, 34018.319633607345, 34101.1474713132, 34219.65780342196, 34705.305893882105, 34724.82637586815, 35099.29801403977, 35141.82429087851, 35208.0, 8427.915720842806, 8562.61468233931, 8587.785305367353, 8614.827703445959, 8631.611577479029, 8440.28257598105, 8695.608697608623, 8695.913040869573, 8703.173198546128, 8735.21383075523, 8662.956685216597, 8703.825923481527, 8772.254358379545, 8774.0, 8775.824483510325, 8699.652013919436, 8718.520481373522, 8737.30101591871, 8763.0, 8763.912360876406, 8687.218150366434, 8745.518996455192, 8784.868226976601, 8798.164174403486, 8803.075677053881, 32739.50890736641, 33380.33239335224, 33411.83294083538, 33425.49861752076, 33491.49762753561, 3570.589382221052, 3578.4095624221973, 3609.3322735294055, 3636.654517820803, 3743.251349730038, 26648.0, 26760.59859102115, 26797.732022679913, 26893.0, 27580.862095689394, 4415.955840441618, 4440.755758433284, 4469.955300446986, 4518.728876267402, 4550.635949124062, 285806.0, 288164.0, 288938.0, 290804.0, 292731.0, 33202.16994575155, 33897.49153762696, 49072.75463622659, 49225.50774492281, 49257.0, 32914.50628240578, 32947.67052329494, 32967.3406531868, 33046.83476582602, 33129.0, 13622.727545449035, 13708.108972916729, 13780.65548361299, 13818.861811381757, 13846.792298115537, 10543.630972915911, 10616.0, 10626.787464250672, 10640.574377024986, 10668.733281668021, 8249.546274954815, 8344.123866994, 8349.874751878726, 8354.039285482126, 8418.200270974248, 3347.0795531229105, 3440.4884434362557, 3461.7230621550216, 3482.2513159670284, 3491.6159222485508, 1043.8173319669027, 1058.433737950193, 1091.4542728635681, 1098.5770478365887, 1182.9290242585473, 28823.423531529254, 28845.711542884303, 29071.709282907323, 29074.85462572716, 29369.0, 1088.8094583447864, 1121.2319561100671, 1121.814900541418, 1129.9152563557602, 1150.2408410449063, 15276.541703748906, 15360.231988400536, 15366.0, 15450.150241736812, 15582.45461408868, 478091.0, 514473.0, 523304.0, 524061.0, 799924.0, 47465.28802067972, 48957.75521122443, 49102.0, 49214.261786073235, 49382.753086235054, 1310.377570653951, 1314.1129737427389, 1322.0481253497467, 1326.157889740022, 1342.812006319116, 29613.555796662637, 29617.851910740308, 29881.70118298876, 30234.24414389658, 30415.847920760254, 44215.778921106474, 44223.77888110539, 44433.11133777371, 44524.55475445204, 44570.55429445664, 417850.0, 418712.0, 420130.0, 420403.0, 424511.0, 27290.72709272882, 38644.420333695576, 39228.0, 39473.60526394699, 39535.20929581335, 37934.43098353582, 38400.6159938397, 38601.6139838598, 38881.80559097186, 38896.80551597224, 32958.835205823816, 33297.0, 33654.49518257277, 33768.0, 33800.15499612431, 33523.497147542315, 33699.49450758191, 33866.153346166546, 33902.66097338995, 36233.81883090568, 34815.12962175966, 35150.472742908365, 35299.0, 35382.29235415226, 37709.4343584841, 31613.0, 32234.83882580572, 32273.193170170933, 32501.674983249864, 34296.82851585726, 25072.74927250704, 25735.485290293716, 25812.09657661973, 25973.480530389665, 26191.869040654674], "value": 17466.143050268707, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.5986114232912, 396.74608250719524, 402.4968789013733, 403.84451985985396, 416.89994401343665, 17512.737308940377, 17713.214620431125, 18226.27094916202, 18234.361797337097, 18321.81678183221, 15277.0, 15787.131707756069, 15906.52280431586, 15914.442994495195, 15939.442119525818, 5045.470225626303, 5251.264822924793, 5261.105612045962, 5286.788528458857, 5298.708571028592, 5152.639315247934, 5226.738663066851, 5229.450907654698, 5237.13587258102, 5238.580913526908, 5236.162214045753, 5430.5384042356445, 5695.174199741035, 5699.173619825123, 5719.027765279912, 5610.0, 5644.209810626516, 5661.46216109469, 5876.647401155901, 6243.500519958392, 5575.470330318613, 5581.2186293918885, 5615.298087739033, 5632.493075623172, 5660.971695141498, 13609.931950340284, 14818.703625927421, 20019.699704504445, 20580.5883882323, 21419.464513387135, 2357.2574638988663, 2441.414060625455, 2453.4847681986803, 2519.0, 2597.5324441600505, 10444.582216711322, 10618.203634727426, 10648.840267395995, 10721.731956701067, 10935.398553079578, 1971.9704204436946, 2012.4365177750108, 2081.2923605973892, 2082.250389859649, 2092.5501017281204, 73322.0, 74571.99999999946, 75212.24787752108, 75977.62011189964, 76911.61544192299, 10560.577576896992, 10619.787604247871, 10665.146788256921, 10888.40113793749, 10955.616553420592, 15008.924955375152, 15025.924870375797, 15046.924765376103, 15079.321430535652, 15133.621659458382, 6794.8641027180165, 7223.747168849065, 7313.780586582411, 7466.365358944442, 7555.508891922007, 7050.153981522148, 7095.503314767917, 7296.0, 7517.436192285491, 7541.4343924205905, 4613.308003799457, 4689.929651055237, 4732.2428411454, 4732.384789977281, 4781.42622885256, 1961.1763059514753, 2036.297477370305, 2054.845886558514, 2069.368842503051, 2101.8003289687454, 868.8827008353918, 946.1720994130136, 953.5899563187758, 997.4713401897006, 1017.3387298256044, 16641.750373744402, 17436.825631743774, 17582.38461653836, 17916.552086197687, 18069.638607227782, 940.2759874896292, 945.3571571331423, 951.7287573041789, 955.2501286490071, 990.0594435286507, 9386.95306523463, 9873.456959867133, 9893.159081478156, 9913.256505761952, 9980.80038399228, 267476.0, 284687.0, 522342.0, 526397.0, 531133.0, 58712.0, 58912.7054364734, 60277.0, 96252.51873740727, 97074.51462742641, 979.4612962870393, 1006.8338724110587, 1013.8073765984586, 1080.8811030786608, 1092.595739576346, 16359.509214723577, 16464.259108339913, 16475.83524164743, 16533.751993719863, 16795.748063779298, 38115.80942095272, 38354.0411489715, 39646.60353396429, 39907.201855962136, 40164.19671606493, 55298.0, 58024.0, 58077.709611451675, 58257.70871145617, 58326.4167358321, 8614.3108551317, 8621.784455388666, 8719.956400217958, 8816.911830881609, 8899.955500222457, 9214.723558293263, 11308.943455282671, 12031.699207519881, 12251.632451026484, 12305.753884922073, 10719.946400267949, 10987.505562249878, 10990.725231869268, 10998.34009959405, 11054.336739795637, 10330.225233107396, 10430.947845260725, 10438.11276041545, 10515.421651808918, 10578.206634502289, 6155.230596175478, 7594.392448604209, 10519.316244444393, 11040.33757974524, 11266.380349080551, 8370.330373570221, 8494.065652778312, 8600.655973760979, 8660.09069047741, 8675.956620216859, 9642.662506812228, 10186.643467478603, 10222.335548189343, 10454.895451045391, 10476.947615261875], "value": 8681.922194836798, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.2132830965575, 1328.5217321764162, 1376.298087975133, 1525.5652139140348, 1529.6175956010998, 7416.777496675095, 8127.75616731499, 8240.38197135215, 8436.957815210932, 8460.57697115144, 8179.0, 8228.506289622626, 8364.58177091146, 8438.409311348209, 8438.620262088205, 2417.383567190364, 2422.697162854643, 2424.8060155187586, 2438.8048956083558, 2442.6213936839818, 2376.512814872947, 2436.5492383908945, 2438.6463962725393, 2439.731629520751, 2444.303373538542, 2377.1679912030736, 2388.534235824015, 2412.5054363855456, 2421.1646981791255, 2423.5758742220128, 2339.6139636959883, 2351.6119840226343, 2430.453148041694, 2444.743301953296, 2449.8530088194766, 2420.5037967216676, 2424.5393375258645, 2452.31335226137, 2453.546093972603, 2456.4841383309526, 8493.532855692934, 8501.0, 8501.702440414618, 8546.914530854674, 8589.742307730778, 5077.0607437623785, 5184.792608295664, 5211.661242019294, 5219.164933610604, 5236.7119808410525, 3361.8151001694896, 3466.3067386522544, 3467.497212904115, 3472.461768425898, 3490.3193877193958, 1138.8234823602354, 1139.8347239650286, 1151.067635215478, 1157.1610582327828, 1159.9652010439615, 12240.143189976616, 12282.38588070593, 12289.93855030728, 12377.133600647958, 12389.566365177176, 4541.750203738826, 4583.0, 4646.4888862225125, 4667.9766601166775, 4714.080754252887, 9708.368956017977, 9731.124198821999, 9764.658236961672, 9768.609255629695, 9793.314467987315, 5216.66091704038, 5239.580833533309, 5239.711815850165, 5243.056249874983, 5243.056249874983, 4358.215521206213, 4609.7695115244105, 4710.293455981561, 4738.19450693383, 4846.36997190363, 3795.0, 3818.045488627843, 3837.175007373428, 3877.573466918693, 3907.081835768592, 1202.8436303280519, 1214.678110300771, 1215.3437143942172, 1235.1354052163522, 1244.1850587864963, 832.9541875196923, 853.7694822397917, 879.2702057292432, 894.3203165594196, 916.876221710074, 5800.0, 5857.765689372377, 5876.382979787147, 5941.881162376728, 5954.612950158313, 875.094277422877, 884.7964968057382, 907.3331101640289, 920.9493477858648, 963.9469829159324, 3820.2359528093934, 3840.9245411284883, 3856.267309211241, 3875.2443273561385, 3878.8254528545717, 10434.843477347846, 10473.528691208914, 10728.73178170552, 10733.624323148651, 10754.40850753216, 10570.630027948984, 10766.300190487593, 10815.78368432627, 10881.238313317992, 10890.945545272381, 8051.959740201261, 8053.516788992679, 8123.9593802031795, 8131.796705082302, 8135.430519863553, 5704.914426283526, 5736.19693242938, 5770.5095066919785, 5782.2194003808945, 5821.155932389695, 9307.441553506811, 9465.148136667733, 9470.57382417779, 9550.713478595653, 9636.662716804878, 9175.541222938693, 9556.76108097303, 9610.855837162588, 9678.661246856327, 9695.321327507007, 6887.862242755217, 7433.9256607433235, 7600.2779735925, 7669.654865531176, 7750.341220996053, 8034.276915077671, 8060.516369017878, 8125.106238313899, 8186.590670466572, 8211.95894020526, 6688.331166883273, 6760.492963027891, 7005.824854378681, 7209.531380460253, 7280.199178090512, 7249.746258881125, 7256.346928776436, 7301.8299536891245, 7307.5980821055355, 7328.890066648898, 6808.251092379934, 6977.511574189758, 6987.755428559976, 6997.300269972962, 7001.649917504003, 4879.219324907997, 4933.827316043921, 4994.325766021686, 5042.697438153723, 5046.419661738947, 4995.125852975787, 5012.849614511425, 5019.7490125494305, 5059.569936555434, 5060.569851562658], "value": 4531.669010032129, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.37842910194456, 362.2591799769471, 364.91606930406004, 368.2910397484841, 369.5306960160596, 6519.641419721914, 6561.442277406414, 6602.075709400682, 6616.867662646744, 6653.9667301663485, 6644.9700296454, 6682.331766823315, 6690.397864192221, 6694.665266736668, 6694.832629184273, 5048.520390562909, 5085.110105731501, 5087.720175390352, 5093.847184584469, 5103.56619687327, 5083.110455670261, 5091.058154241458, 5098.133317336044, 5102.770375333119, 5104.923426148593, 5048.394192696863, 5053.014662140884, 5057.393112826466, 5061.3420255366755, 5064.56951159152, 4934.654574179791, 5031.572316353115, 5033.974830125862, 5044.066847633163, 5048.848534543951, 4389.561043895616, 4415.470143582758, 4415.779211039435, 4416.933745993812, 4434.778261086933, 6375.043743438475, 6376.043593460971, 6387.808365749035, 6404.327545607737, 6435.066915297302, 5746.741396637161, 5833.4749872511675, 5903.645781253139, 5914.053751399755, 5932.080527518198, 6892.689828957709, 6935.271796461399, 7000.50996430245, 7034.3669069783455, 7055.188653304885, 4952.925706114411, 4953.405591329028, 4955.628327875424, 4969.950300496985, 4971.27916452116, 7272.236415176383, 7362.631868406612, 7363.77908662741, 7365.189829118793, 7381.88927166093, 4910.950890491121, 5071.264666623319, 5098.337216161949, 5109.6678715883345, 5119.48805119485, 5160.380754309507, 5184.040952423738, 5192.350956130484, 5198.792048318025, 5204.089284375219, 5910.054391297372, 5924.674142922181, 5936.910946335722, 5939.70301484924, 5942.584019118706, 7094.219635840053, 7122.857542849114, 7125.144982602121, 7125.92874071263, 7132.28677132293, 1800.0009994452942, 1828.8902665840092, 1829.8563397876328, 1830.1581272614746, 1830.3776715916385, 1126.571902676994, 1168.1764356128908, 1200.0279773383588, 1214.247166756599, 1225.9080568957186, 6643.534952553275, 6892.379685828299, 6897.862042759117, 6925.238223795379, 6939.375456208965, 7353.0441042664115, 7357.0803649543805, 7361.190269070398, 7370.041894553674, 7379.372753315921, 6872.69072891721, 6913.446924246048, 6936.306369363124, 6936.514443988974, 6944.756933507303, 3886.378179491268, 3925.8822235332987, 3958.0698535844053, 3959.0102474381406, 3982.123932734794, 7618.0, 7690.423218258541, 7693.769186924401, 7693.922850800893, 7708.9229107709325, 7485.363744081814, 7497.437692173109, 7505.812354691067, 7554.0, 7554.131274903457, 7634.4655874088285, 7636.160022397532, 7666.156722760492, 7675.846483070419, 7689.653965571562, 7197.100362454693, 7337.119545654556, 7383.224761400191, 7406.814829629302, 7407.0, 7248.130224373109, 7268.41852651776, 7270.927290727025, 7278.563286202845, 7285.562866227831, 7533.322001019935, 7654.578998155155, 7680.577568233801, 7686.961565192139, 7716.0, 5093.6179786516905, 5143.819966301162, 5145.588352931682, 5149.459306772735, 5157.742112894265, 7103.289671033062, 7287.234840341688, 7309.853802924018, 7311.780646580611, 7361.668724907285, 7134.750283740044, 7159.0, 7168.569885806868, 7170.533915295698, 7172.856542869009, 7059.717611295696, 7068.0, 7101.8579628406105, 7106.395956343768, 7120.537165084253, 6879.484038697218, 6912.447004239548, 6965.5124141309625, 6967.233604303624, 6981.162260528769, 7034.1910680270375, 7098.609576473344, 7152.821179470555, 7172.928270717226, 7174.641267936478, 6683.565568238049, 6868.107146070979, 6952.826179345557, 6959.61722105289, 7025.227225005143], "value": 5356.211861184107, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.1050190003945, 701.5650296815975, 709.4041005555334, 730.3171534615132, 734.3354264390725, 14103.929480352597, 14187.78718319226, 14214.076085054465, 14238.430462781489, 14377.209253491066, 13721.313934303269, 13994.370253338599, 14049.086809357384, 14059.578212653636, 14116.57650270491, 603.7886739641124, 614.1463365921372, 614.2322097378277, 616.2697203813473, 617.5275913925827, 613.4632196827775, 615.3415845045803, 616.3866952382385, 616.7810427298311, 620.1008537620446, 852.3862818770506, 854.9658013679446, 855.3670283989865, 860.4407135362002, 861.4013260783757, 855.3328403844948, 855.8117214212863, 857.4469467193687, 858.7295002074358, 859.055039456599, 625.9217597800275, 627.8085184018872, 629.326620516048, 630.8202162383744, 631.6589041917359, 13478.460861565525, 13602.047856650039, 13609.455621775118, 13634.250116243602, 13712.588622341345, 13571.864281357257, 13847.16916984974, 13916.58250252494, 13931.791023134661, 13992.650183745385, 11646.818476256947, 11853.348065856375, 11886.108541859396, 12091.879081209163, 12093.45579448927, 3868.6905047596124, 3904.082540602956, 3915.3735402335774, 3942.2115576884453, 4074.5721699221453, 60530.092048619306, 60880.391196088356, 61121.38878611202, 61379.693101534656, 61398.0, 10384.844227336596, 10504.159667226604, 10584.735381615521, 10800.297980631234, 10862.131029517619, 18485.907570462332, 18524.907375463037, 18631.534211644546, 18694.81305186958, 18765.530861728294, 7879.527228366316, 8099.190080991972, 8173.836523269501, 8229.218224268805, 8310.916890831135, 4974.7263900485095, 5007.524285192901, 5033.5721463676, 5095.745212739348, 5179.093658609729, 3445.3798316303305, 3453.4819777033645, 3468.7745296555645, 3481.286336301103, 3487.3548393547276, 594.485769809112, 598.2790737161797, 598.8892054969845, 599.7990673124465, 602.8312072619674, 654.4698793976894, 663.626700046685, 704.9506534542635, 746.3432179681954, 754.705664790732, 9573.473458959825, 9844.458554779412, 9910.44419083308, 9966.601335946481, 9968.302218844756, 618.227215980025, 664.455146779636, 710.0308079471484, 735.6910097758954, 761.7372006657695, 4422.270325396338, 4651.0, 4698.976505117521, 4851.126797176542, 4868.683535570177, 56916.0, 63567.364326356146, 64120.35879641237, 64206.678966604864, 64591.0, 49368.25947610789, 49735.0, 50022.749886250334, 50497.0, 51118.48881511212, 48128.5187148131, 48635.27047094297, 52085.0, 54242.18636720452, 54976.17535736967, 10265.384076955406, 10324.277300588887, 10381.584736610452, 10473.633422830164, 10594.364338139736, 37022.62977370192, 38414.423783643826, 39245.60754392534, 40255.59744402519, 40736.79631601823, 45530.54469455263, 49781.253281201534, 50359.74820126023, 53038.73480632572, 53314.66524496754, 11438.714032149262, 11561.248518846249, 11640.243384180001, 12004.819927700917, 12052.216605920587, 13816.309184540934, 14039.298035098409, 14210.644733881736, 14211.360488778237, 14707.632309192355, 12640.620781376574, 13017.088803783645, 13419.597412077654, 13490.52783152585, 13865.376058077612, 13095.279759613313, 13114.950803935471, 13262.27057511846, 13549.187048777105, 13671.453141874214, 12309.384530773246, 12542.310172940575, 12988.935055324662, 13353.866461335263, 13718.45126194941, 11230.719232019264, 11532.94233528827, 11533.250338727956, 11538.59614913474, 11968.341741204318, 11243.212975091665, 11385.0, 11416.200865939305, 11448.484818183035, 11490.0], "value": 6788.251343151227, "unit": "score"}], "name": "dromaeo_css", "value": 7212.244946319783, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 112.0, 106.0, 110.0, 113.0, 117.0, 101.0, 110.0, 112.0, 112.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 135.0, 155.0, 179.0, 131.0, 165.0, 160.0, 128.0, 178.0, 128.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 170.0, 163.0, 162.0, 164.0, 163.0, 163.0, 162.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 75.0, 170.0, 76.0, 77.0, 76.0, 85.0, 168.0, 77.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 162.0, 91.0, 92.0, 92.0, 148.0, 93.0, 91.0, 152.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 97.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 58.0, 55.0, 55.0, 54.0, 77.0, 54.0, 57.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 58.0, 57.0, 57.0, 58.0, 58.0, 58.0, 59.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 73.0, 75.0, 75.0, 77.0, 74.0, 75.0, 74.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 116.0, 122.0, 117.0, 113.0, 139.0, 131.0], "value": 119.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 158.0, 167.0, 158.0, 158.0, 167.0, 160.0, 157.0, 159.0, 159.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 76.0, 68.0, 64.0, 67.0, 65.0, 65.0, 64.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1525.9, "alertThreshold": 2.0}]} 03:32:02 INFO - Return code: 0 03:32:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:32:02 ERROR - # TBPL SUCCESS # 03:32:02 INFO - Running post-action listener: _resource_record_post_action 03:32:02 INFO - Running post-run listener: _resource_record_post_run 03:32:03 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 270336; Write bytes: 508866560; Read time: 212; Write time: 421700 03:32:03 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 256057344; Read time: 0; Write time: 268992 03:32:03 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 270336; Write bytes: 252289024; Read time: 212; Write time: 152704 03:32:03 INFO - Running post-run listener: _upload_blobber_files 03:32:03 INFO - Blob upload gear active. 03:32:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:32:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:32:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:32:03 INFO - (blobuploader) - INFO - Open directory for files ... 03:32:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:32:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:32:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:04 INFO - (blobuploader) - INFO - Done attempting. 03:32:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:32:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:32:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:05 INFO - (blobuploader) - INFO - Done attempting. 03:32:05 INFO - (blobuploader) - INFO - Iteration through files over. 03:32:05 INFO - Return code: 0 03:32:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:32:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:32:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e11cdb7a8d2e6db0e43dbac5df0bbf2d6b48dde1793ec095b6abb66953721522017af0d6c388087c06ea874bf67ee816d573683ae22d4798e19c6ac00f768dad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59d0e806e578d50ea36a820f590cedbc7834a3c7b69c4b149ca8660fe19ea62112f1b4284dcfa357ce6250e4a0b646ed31b20e3029bf3e3c1c9ae28f89853c06"} 03:32:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:32:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:32:05 INFO - Contents: 03:32:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e11cdb7a8d2e6db0e43dbac5df0bbf2d6b48dde1793ec095b6abb66953721522017af0d6c388087c06ea874bf67ee816d573683ae22d4798e19c6ac00f768dad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59d0e806e578d50ea36a820f590cedbc7834a3c7b69c4b149ca8660fe19ea62112f1b4284dcfa357ce6250e4a0b646ed31b20e3029bf3e3c1c9ae28f89853c06"} 03:32:05 INFO - Running post-run listener: copy_logs_to_upload_dir 03:32:05 INFO - Copying logs to upload dir... 03:32:05 INFO - mkdir: /builds/slave/test/build/upload/logs 03:32:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.652229 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-28 03:32:04.972576) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:32:04.975942) ========= 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=0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103 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/e11cdb7a8d2e6db0e43dbac5df0bbf2d6b48dde1793ec095b6abb66953721522017af0d6c388087c06ea874bf67ee816d573683ae22d4798e19c6ac00f768dad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59d0e806e578d50ea36a820f590cedbc7834a3c7b69c4b149ca8660fe19ea62112f1b4284dcfa357ce6250e4a0b646ed31b20e3029bf3e3c1c9ae28f89853c06"} build_url:https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/FQnWc9y1SQG6rB-aTRfA3w/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e11cdb7a8d2e6db0e43dbac5df0bbf2d6b48dde1793ec095b6abb66953721522017af0d6c388087c06ea874bf67ee816d573683ae22d4798e19c6ac00f768dad", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59d0e806e578d50ea36a820f590cedbc7834a3c7b69c4b149ca8660fe19ea62112f1b4284dcfa357ce6250e4a0b646ed31b20e3029bf3e3c1c9ae28f89853c06"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:32:05.003539) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:32:05.004038) ========= 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=0333a256a5e4f052382dd180000001b1-1464430296.454341-137512103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:32:05.087285) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:32:05.087842) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:32:05.088387) ========= ========= Total master_lag: 0.17 =========