builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1462964744.45 results: success (0) buildid: 20160510142413 builduid: 93e058acf8334e7aae447a8479c457fb revision: 1dd42a351054c5b697873d647169019d4d77d762 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.449699) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.450158) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.450437) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.470510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.470944) ========= 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=14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 04:05:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 440M=0s 2016-05-11 04:05:45 (440 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117311 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.597605) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.597919) ========= 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=14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009627 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.644395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:44.644760) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1dd42a351054c5b697873d647169019d4d77d762 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1dd42a351054c5b697873d647169019d4d77d762 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 04:05:45,289 truncating revision to first 12 chars 2016-05-11 04:05:45,289 Setting DEBUG logging. 2016-05-11 04:05:45,289 attempt 1/10 2016-05-11 04:05:45,289 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1dd42a351054?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 04:05:45,631 unpacking tar archive at: mozilla-aurora-1dd42a351054/testing/mozharness/ program finished with exit code 0 elapsedTime=0.586841 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:45.239970) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:45.240287) ========= script_repo_revision: 1dd42a351054c5b697873d647169019d4d77d762 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:45.240726) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:45.240994) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 04:05:45.246820) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 19 secs) (at 2016-05-11 04:05:45.247145) ========= /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=14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:45 INFO - MultiFileLogger online at 20160511 04:05:45 in /builds/slave/test 04:05:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:05:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:45 INFO - {'append_to_log': False, 04:05:45 INFO - 'base_work_dir': '/builds/slave/test', 04:05:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:05:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:45 INFO - 'branch': 'Mozilla-Aurora', 04:05:45 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:45 INFO - 'config_files': ('talos/linux_config.py',), 04:05:45 INFO - 'default_actions': ('clobber', 04:05:45 INFO - 'read-buildbot-config', 04:05:45 INFO - 'download-and-extract', 04:05:45 INFO - 'populate-webroot', 04:05:45 INFO - 'create-virtualenv', 04:05:45 INFO - 'install', 04:05:45 INFO - 'run-tests'), 04:05:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:45 INFO - 'download_minidump_stackwalk': True, 04:05:45 INFO - 'download_symbols': 'ondemand', 04:05:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:45 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:45 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:45 INFO - 'installer_path': 'installer.exe', 04:05:45 INFO - 'log_level': 'info', 04:05:45 INFO - 'log_name': 'talos', 04:05:45 INFO - 'log_to_console': True, 04:05:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:45 INFO - 'opt_config_files': (), 04:05:45 INFO - 'pip_index': False, 04:05:45 INFO - 'sps_profile': False, 04:05:45 INFO - 'sps_profile_interval': 0, 04:05:45 INFO - 'suite': 'dromaeojs-e10s', 04:05:45 INFO - 'system_bits': '32', 04:05:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:45 INFO - 'title': 'talos-linux64-ix-036', 04:05:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:45 INFO - 'use_talos_json': True, 04:05:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:45 INFO - 'work_dir': 'build'} 04:05:45 INFO - ##### 04:05:45 INFO - ##### Running clobber step. 04:05:45 INFO - ##### 04:05:45 INFO - Running pre-action listener: _resource_record_pre_action 04:05:45 INFO - Running main action method: clobber 04:05:45 INFO - rmtree: /builds/slave/test/build 04:05:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:46 INFO - Running post-action listener: _resource_record_post_action 04:05:46 INFO - ##### 04:05:46 INFO - ##### Running read-buildbot-config step. 04:05:46 INFO - ##### 04:05:46 INFO - Running pre-action listener: _resource_record_pre_action 04:05:46 INFO - Running main action method: read_buildbot_config 04:05:46 INFO - Using buildbot properties: 04:05:46 INFO - { 04:05:46 INFO - "project": "", 04:05:46 INFO - "product": "firefox", 04:05:46 INFO - "script_repo_revision": "production", 04:05:46 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:05:46 INFO - "repository": "", 04:05:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:05:46 INFO - "buildid": "20160510142413", 04:05:46 INFO - "pgo_build": "True", 04:05:46 INFO - "basedir": "/builds/slave/test", 04:05:46 INFO - "buildnumber": 260, 04:05:46 INFO - "slavename": "talos-linux64-ix-036", 04:05:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:05:46 INFO - "platform": "ubuntu64_hw", 04:05:46 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:05:46 INFO - "branch": "mozilla-aurora", 04:05:46 INFO - "repo_path": "releases/mozilla-aurora", 04:05:46 INFO - "revision": "1dd42a351054c5b697873d647169019d4d77d762", 04:05:46 INFO - "stage_platform": "linux64-pgo", 04:05:46 INFO - "builduid": "93e058acf8334e7aae447a8479c457fb", 04:05:46 INFO - "slavebuilddir": "test" 04:05:46 INFO - } 04:05:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 04:05:46 INFO - Running post-action listener: _resource_record_post_action 04:05:46 INFO - ##### 04:05:46 INFO - ##### Running download-and-extract step. 04:05:46 INFO - ##### 04:05:46 INFO - Running pre-action listener: _resource_record_pre_action 04:05:46 INFO - Running main action method: download_and_extract 04:05:46 INFO - mkdir: /builds/slave/test/build/tests 04:05: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')]} 04:05:46 INFO - https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:05:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:05:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:05:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:05:47 INFO - Downloaded 1361 bytes. 04:05:47 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:05:47 INFO - Using the following test package requirements: 04:05:47 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:05:47 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:05:47 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:05:47 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:47 INFO - u'jsshell-linux-x86_64.zip'], 04:05:47 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:05:47 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:05:47 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:05:47 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:05:47 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:05:47 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:05:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:05:47 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:47 INFO - https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:05:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:05:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:05:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:05:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:05:48 INFO - Downloaded 23800226 bytes. 04:05:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:05:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:05:49 INFO - Return code: 0 04:05:49 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:49 INFO - https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:05:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:05:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:05:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:05:50 INFO - Downloaded 23800226 bytes. 04:05:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:05:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:05:51 INFO - Return code: 0 04:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:51 INFO - https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:05:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:05:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:05:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:05:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:05:52 INFO - Downloaded 10840145 bytes. 04:05:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:05:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:05:52 INFO - Return code: 0 04:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:52 INFO - https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:05:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:05:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:05:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:05:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:05:54 INFO - Downloaded 62686755 bytes. 04:05:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:05:54 INFO - mkdir: /builds/slave/test/properties 04:05:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:05:54 INFO - Writing to file /builds/slave/test/properties/build_url 04:05:54 INFO - Contents: 04:05:54 INFO - build_url:https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:05:55 INFO - Running post-action listener: _resource_record_post_action 04:05:55 INFO - Running post-action listener: set_extra_try_arguments 04:05:55 INFO - ##### 04:05:55 INFO - ##### Running populate-webroot step. 04:05:55 INFO - ##### 04:05:55 INFO - Running pre-action listener: _resource_record_pre_action 04:05:55 INFO - Running main action method: populate_webroot 04:05:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:05:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:05:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:05:55 INFO - '--tppagecycles', 04:05:55 INFO - '7'], 04:05:55 INFO - 'tests': ['tsvgm']}}, 04:05:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:05:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:05:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:05:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:05:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:55 INFO - 'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:55 INFO - 'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['damp', 'tps']}, 04:05:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:55 INFO - 'tests': ['damp', 'tps']}, 04:05:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['dromaeo_dom']}, 04:05:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:05:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['a11yr', 04:05:55 INFO - 'ts_paint', 04:05:55 INFO - 'tpaint', 04:05:55 INFO - 'sessionrestore', 04:05:55 INFO - 'sessionrestore_no_auto_restore', 04:05:55 INFO - 'tabpaint']}, 04:05:55 INFO - 'other-e10s': {'tests': ['a11yr', 04:05:55 INFO - 'ts_paint', 04:05:55 INFO - 'tpaint', 04:05:55 INFO - 'sessionrestore', 04:05:55 INFO - 'sessionrestore_no_auto_restore', 04:05:55 INFO - 'tabpaint']}, 04:05:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:05:55 INFO - 'ts_paint', 04:05:55 INFO - 'tpaint', 04:05:55 INFO - 'sessionrestore', 04:05:55 INFO - 'sessionrestore_no_auto_restore', 04:05:55 INFO - 'tabpaint']}, 04:05:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:05:55 INFO - 'ts_paint', 04:05:55 INFO - 'tpaint', 04:05:55 INFO - 'sessionrestore', 04:05:55 INFO - 'sessionrestore_no_auto_restore', 04:05:55 INFO - 'tabpaint']}, 04:05:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['a11yr', 04:05:55 INFO - 'ts_paint', 04:05:55 INFO - 'tpaint', 04:05:55 INFO - 'sessionrestore', 04:05:55 INFO - 'sessionrestore_no_auto_restore', 04:05:55 INFO - 'tabpaint']}, 04:05:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['a11yr', 04:05:55 INFO - 'ts_paint', 04:05:55 INFO - 'tpaint', 04:05:55 INFO - 'sessionrestore', 04:05:55 INFO - 'sessionrestore_no_auto_restore', 04:05:55 INFO - 'tabpaint']}, 04:05:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['tsvgx', 04:05:55 INFO - 'tsvgr_opacity', 04:05:55 INFO - 'tart', 04:05:55 INFO - 'tscrollx', 04:05:55 INFO - 'cart']}, 04:05:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:05:55 INFO - 'tsvgr_opacity', 04:05:55 INFO - 'tart', 04:05:55 INFO - 'tscrollx', 04:05:55 INFO - 'cart']}, 04:05:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:55 INFO - 'talos_options': ['--disable-e10s'], 04:05:55 INFO - 'tests': ['tp5o']}, 04:05:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:55 INFO - 'tests': ['tp5o']}, 04:05:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:55 INFO - 'talos_options': ['--disable-e10s', 04:05:55 INFO - '--xperf_path', 04:05:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:55 INFO - 'tests': ['tp5n']}, 04:05:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:55 INFO - 'talos_options': ['--xperf_path', 04:05:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:55 INFO - 'tests': ['tp5n']}}, 04:05:55 INFO - 'talos.zip': {'path': '', 04:05:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:05:55 INFO - Running post-action listener: _resource_record_post_action 04:05:55 INFO - ##### 04:05:55 INFO - ##### Running create-virtualenv step. 04:05:55 INFO - ##### 04:05:55 INFO - Running pre-action listener: _resource_record_pre_action 04:05:55 INFO - Running main action method: create_virtualenv 04:05:55 INFO - Creating virtualenv /builds/slave/test/build/venv 04:05:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:05:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:05:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:05:55 INFO - Using real prefix '/usr' 04:05:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:05:55 INFO - Installing distribute.............................................................................................................................................................................................done. 04:05:57 INFO - Installing pip.................done. 04:05:57 INFO - Return code: 0 04:05:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:05: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')]} 04:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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')]} 04:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec119ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15075a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596410>, '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 0x1597310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15977a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05: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', 'pip>=1.5'] in /builds/slave/test/build 04:05: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 pip>=1.5 04:05:57 INFO - Using env: {'DISPLAY': ':0', 04:05:57 INFO - 'HOME': '/home/cltbld', 04:05:57 INFO - 'LANG': 'en_US.UTF-8', 04:05:57 INFO - 'LANGUAGE': 'en_US:en', 04:05:57 INFO - 'LOGNAME': 'cltbld', 04:05:57 INFO - 'MAIL': '/var/mail/cltbld', 04:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:57 INFO - 'MOZ_NO_REMOTE': '1', 04:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:57 INFO - 'NO_EM_RESTART': '1', 04:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:57 INFO - 'PWD': '/builds/slave/test', 04:05:57 INFO - 'SHELL': '/bin/bash', 04:05:57 INFO - 'SHLVL': '1', 04:05:57 INFO - 'TERM': 'linux', 04:05:57 INFO - 'TMOUT': '86400', 04:05:57 INFO - 'USER': 'cltbld', 04:05:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 04:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:57 INFO - '_': '/tools/buildbot/bin/python'} 04:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:05:57 INFO - Cleaning up... 04:05:57 INFO - Return code: 0 04:05:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:05: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')]} 04:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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')]} 04:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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', '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 0x7fec119ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15075a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596410>, '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 0x1597310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15977a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:05: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', 'psutil>=0.7.1'] in /builds/slave/test/build 04:05: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 psutil>=0.7.1 04:05:57 INFO - Using env: {'DISPLAY': ':0', 04:05:57 INFO - 'HOME': '/home/cltbld', 04:05:57 INFO - 'LANG': 'en_US.UTF-8', 04:05:57 INFO - 'LANGUAGE': 'en_US:en', 04:05:57 INFO - 'LOGNAME': 'cltbld', 04:05:57 INFO - 'MAIL': '/var/mail/cltbld', 04:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:57 INFO - 'MOZ_NO_REMOTE': '1', 04:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:57 INFO - 'NO_EM_RESTART': '1', 04:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:57 INFO - 'PWD': '/builds/slave/test', 04:05:57 INFO - 'SHELL': '/bin/bash', 04:05:57 INFO - 'SHLVL': '1', 04:05:57 INFO - 'TERM': 'linux', 04:05:57 INFO - 'TMOUT': '86400', 04:05:57 INFO - 'USER': 'cltbld', 04:05:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 04:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:57 INFO - '_': '/tools/buildbot/bin/python'} 04:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:58 INFO - Downloading/unpacking psutil>=0.7.1 04:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:05:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:59 INFO - Installing collected packages: psutil 04:05:59 INFO - Running setup.py install for psutil 04:06:00 INFO - building 'psutil._psutil_linux' extension 04:06:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:06:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:06:00 INFO - building 'psutil._psutil_posix' extension 04:06:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:06:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:06:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:00 INFO - Successfully installed psutil 04:06:00 INFO - Cleaning up... 04:06:00 INFO - Return code: 0 04:06:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:00 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 0x7fec119ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15075a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596410>, '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 0x1597310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15977a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:06:00 INFO - Using env: {'DISPLAY': ':0', 04:06:00 INFO - 'HOME': '/home/cltbld', 04:06:00 INFO - 'LANG': 'en_US.UTF-8', 04:06:00 INFO - 'LANGUAGE': 'en_US:en', 04:06:00 INFO - 'LOGNAME': 'cltbld', 04:06:00 INFO - 'MAIL': '/var/mail/cltbld', 04:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:00 INFO - 'MOZ_NO_REMOTE': '1', 04:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:00 INFO - 'NO_EM_RESTART': '1', 04:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:00 INFO - 'PWD': '/builds/slave/test', 04:06:00 INFO - 'SHELL': '/bin/bash', 04:06:00 INFO - 'SHLVL': '1', 04:06:00 INFO - 'TERM': 'linux', 04:06:00 INFO - 'TMOUT': '86400', 04:06:00 INFO - 'USER': 'cltbld', 04:06:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 04:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:00 INFO - '_': '/tools/buildbot/bin/python'} 04:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:06:02 INFO - Installing collected packages: mozsystemmonitor 04:06:02 INFO - Running setup.py install for mozsystemmonitor 04:06:02 INFO - Successfully installed mozsystemmonitor 04:06:02 INFO - Cleaning up... 04:06:02 INFO - Return code: 0 04:06:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:02 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 0x7fec119ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15075a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596410>, '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 0x1597310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15977a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:06:02 INFO - Using env: {'DISPLAY': ':0', 04:06:02 INFO - 'HOME': '/home/cltbld', 04:06:02 INFO - 'LANG': 'en_US.UTF-8', 04:06:02 INFO - 'LANGUAGE': 'en_US:en', 04:06:02 INFO - 'LOGNAME': 'cltbld', 04:06:02 INFO - 'MAIL': '/var/mail/cltbld', 04:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:02 INFO - 'MOZ_NO_REMOTE': '1', 04:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:02 INFO - 'NO_EM_RESTART': '1', 04:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:02 INFO - 'PWD': '/builds/slave/test', 04:06:02 INFO - 'SHELL': '/bin/bash', 04:06:02 INFO - 'SHLVL': '1', 04:06:02 INFO - 'TERM': 'linux', 04:06:02 INFO - 'TMOUT': '86400', 04:06:02 INFO - 'USER': 'cltbld', 04:06:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 04:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:02 INFO - '_': '/tools/buildbot/bin/python'} 04:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:02 INFO - Downloading/unpacking blobuploader==1.2.4 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06:04 INFO - Downloading blobuploader-1.2.4.tar.gz 04:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:06:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:06:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:05 INFO - Downloading docopt-0.6.1.tar.gz 04:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:06:05 INFO - Installing collected packages: blobuploader, requests, docopt 04:06:05 INFO - Running setup.py install for blobuploader 04:06:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:06:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:06:05 INFO - Running setup.py install for requests 04:06:05 INFO - Running setup.py install for docopt 04:06:05 INFO - Successfully installed blobuploader requests docopt 04:06:05 INFO - Cleaning up... 04:06:05 INFO - Return code: 0 04:06:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:05 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 0x7fec119ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15075a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596410>, '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 0x1597310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15977a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:06:05 INFO - Using env: {'DISPLAY': ':0', 04:06:05 INFO - 'HOME': '/home/cltbld', 04:06:05 INFO - 'LANG': 'en_US.UTF-8', 04:06:05 INFO - 'LANGUAGE': 'en_US:en', 04:06:05 INFO - 'LOGNAME': 'cltbld', 04:06:05 INFO - 'MAIL': '/var/mail/cltbld', 04:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:05 INFO - 'MOZ_NO_REMOTE': '1', 04:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:05 INFO - 'NO_EM_RESTART': '1', 04:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:05 INFO - 'PWD': '/builds/slave/test', 04:06:05 INFO - 'SHELL': '/bin/bash', 04:06:05 INFO - 'SHLVL': '1', 04:06:05 INFO - 'TERM': 'linux', 04:06:05 INFO - 'TMOUT': '86400', 04:06:05 INFO - 'USER': 'cltbld', 04:06:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 04:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:05 INFO - '_': '/tools/buildbot/bin/python'} 04:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:06 INFO - Running setup.py (path:/tmp/pip-uQYfWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:06 INFO - Running setup.py (path:/tmp/pip-4BCSjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:06 INFO - Running setup.py (path:/tmp/pip-1Gjt0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:06 INFO - Running setup.py (path:/tmp/pip-7fxFYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:06 INFO - Running setup.py (path:/tmp/pip-6TcY9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:06 INFO - Running setup.py (path:/tmp/pip-tFn0RA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:06 INFO - Running setup.py (path:/tmp/pip-UGxecc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:06 INFO - Running setup.py (path:/tmp/pip-pXdPin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:06 INFO - Running setup.py (path:/tmp/pip-EGLhLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:06 INFO - Running setup.py (path:/tmp/pip-9lQZo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:06 INFO - Running setup.py (path:/tmp/pip-QnzKMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:06 INFO - Running setup.py (path:/tmp/pip-l8kuJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:06 INFO - Running setup.py (path:/tmp/pip-cNVhQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:06 INFO - Running setup.py (path:/tmp/pip-X57ggQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:06 INFO - Running setup.py (path:/tmp/pip-r1FGv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:06 INFO - Running setup.py (path:/tmp/pip-6zOG5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:07 INFO - Running setup.py (path:/tmp/pip-EV4hTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:06:07 INFO - Running setup.py install for manifestparser 04:06:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:06:07 INFO - Running setup.py install for mozcrash 04:06:07 INFO - Running setup.py install for mozdebug 04:06:07 INFO - Running setup.py install for mozdevice 04:06:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:06:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:06:07 INFO - Running setup.py install for mozfile 04:06:07 INFO - Running setup.py install for mozhttpd 04:06:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:06:07 INFO - Running setup.py install for mozinfo 04:06:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:06:07 INFO - Running setup.py install for mozInstall 04:06:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:06:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:06:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:06:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:06:07 INFO - Running setup.py install for mozleak 04:06:07 INFO - Running setup.py install for mozlog 04:06:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:06:08 INFO - Running setup.py install for moznetwork 04:06:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:06:08 INFO - Running setup.py install for mozprocess 04:06:08 INFO - Running setup.py install for mozprofile 04:06:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:06:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:06:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:06:08 INFO - Running setup.py install for mozrunner 04:06:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:06:08 INFO - Running setup.py install for mozscreenshot 04:06:08 INFO - Running setup.py install for moztest 04:06:08 INFO - Running setup.py install for mozversion 04:06:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:06:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:06:08 INFO - Cleaning up... 04:06:08 INFO - Return code: 0 04:06:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:08 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 0x7fec119ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15075a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596410>, '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 0x1597310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15977a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:06:08 INFO - Using env: {'DISPLAY': ':0', 04:06:08 INFO - 'HOME': '/home/cltbld', 04:06:08 INFO - 'LANG': 'en_US.UTF-8', 04:06:08 INFO - 'LANGUAGE': 'en_US:en', 04:06:08 INFO - 'LOGNAME': 'cltbld', 04:06:08 INFO - 'MAIL': '/var/mail/cltbld', 04:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:08 INFO - 'MOZ_NO_REMOTE': '1', 04:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:08 INFO - 'NO_EM_RESTART': '1', 04:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:08 INFO - 'PWD': '/builds/slave/test', 04:06:08 INFO - 'SHELL': '/bin/bash', 04:06:08 INFO - 'SHLVL': '1', 04:06:08 INFO - 'TERM': 'linux', 04:06:08 INFO - 'TMOUT': '86400', 04:06:08 INFO - 'USER': 'cltbld', 04:06:08 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 04:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:08 INFO - '_': '/tools/buildbot/bin/python'} 04:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:08 INFO - Running setup.py (path:/tmp/pip-WhC_hY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:08 INFO - Running setup.py (path:/tmp/pip-pOcmVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:09 INFO - Running setup.py (path:/tmp/pip-n2TDRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:09 INFO - Running setup.py (path:/tmp/pip-blSBVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:09 INFO - Running setup.py (path:/tmp/pip-Sfw35l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:09 INFO - Running setup.py (path:/tmp/pip-DzG276-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:09 INFO - Running setup.py (path:/tmp/pip-UEZ8cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:09 INFO - Running setup.py (path:/tmp/pip-NFE1pi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:09 INFO - Running setup.py (path:/tmp/pip-KuABxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:09 INFO - Running setup.py (path:/tmp/pip-u0qqg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:09 INFO - Running setup.py (path:/tmp/pip-HAuNnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:09 INFO - Running setup.py (path:/tmp/pip-8YIQke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:09 INFO - Running setup.py (path:/tmp/pip-qozx50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:09 INFO - Running setup.py (path:/tmp/pip-y0SHOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:09 INFO - Running setup.py (path:/tmp/pip-8fUv_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:09 INFO - Running setup.py (path:/tmp/pip-whF8H1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:09 INFO - Running setup.py (path:/tmp/pip-jBvGho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:11 INFO - Downloading blessings-1.6.tar.gz 04:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:06:11 INFO - Installing collected packages: blessings 04:06:11 INFO - Running setup.py install for blessings 04:06:11 INFO - Successfully installed blessings 04:06:11 INFO - Cleaning up... 04:06:12 INFO - Return code: 0 04:06:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:06:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:12 INFO - Reading from file tmpfile_stdout 04:06:12 INFO - Current package versions: 04:06:12 INFO - argparse == 1.2.1 04:06:12 INFO - blessings == 1.6 04:06:12 INFO - blobuploader == 1.2.4 04:06:12 INFO - docopt == 0.6.1 04:06:12 INFO - manifestparser == 1.1 04:06:12 INFO - mozInstall == 1.12 04:06:12 INFO - mozcrash == 0.17 04:06:12 INFO - mozdebug == 0.1 04:06:12 INFO - mozdevice == 0.48 04:06:12 INFO - mozfile == 1.2 04:06:12 INFO - mozhttpd == 0.7 04:06:12 INFO - mozinfo == 0.9 04:06:12 INFO - mozleak == 0.1 04:06:12 INFO - mozlog == 3.1 04:06:12 INFO - moznetwork == 0.27 04:06:12 INFO - mozprocess == 0.22 04:06:12 INFO - mozprofile == 0.28 04:06:12 INFO - mozrunner == 6.11 04:06:12 INFO - mozscreenshot == 0.1 04:06:12 INFO - mozsystemmonitor == 0.0 04:06:12 INFO - moztest == 0.7 04:06:12 INFO - mozversion == 1.4 04:06:12 INFO - psutil == 3.1.1 04:06:12 INFO - requests == 1.2.3 04:06:12 INFO - wsgiref == 0.1.2 04:06:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:12 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 0x7fec119ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15075a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596410>, '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 0x1597310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15977a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:06:12 INFO - Using env: {'DISPLAY': ':0', 04:06:12 INFO - 'HOME': '/home/cltbld', 04:06:12 INFO - 'LANG': 'en_US.UTF-8', 04:06:12 INFO - 'LANGUAGE': 'en_US:en', 04:06:12 INFO - 'LOGNAME': 'cltbld', 04:06:12 INFO - 'MAIL': '/var/mail/cltbld', 04:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:12 INFO - 'MOZ_NO_REMOTE': '1', 04:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:12 INFO - 'NO_EM_RESTART': '1', 04:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:12 INFO - 'PWD': '/builds/slave/test', 04:06:12 INFO - 'SHELL': '/bin/bash', 04:06:12 INFO - 'SHLVL': '1', 04:06:12 INFO - 'TERM': 'linux', 04:06:12 INFO - 'TMOUT': '86400', 04:06:12 INFO - 'USER': 'cltbld', 04:06:12 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 04:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:12 INFO - '_': '/tools/buildbot/bin/python'} 04:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:06:12 INFO - Cleaning up... 04:06:12 INFO - Return code: 0 04:06:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:12 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 0x7fec119ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15075a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596410>, '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 0x1597310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15977a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:06:12 INFO - Using env: {'DISPLAY': ':0', 04:06:12 INFO - 'HOME': '/home/cltbld', 04:06:12 INFO - 'LANG': 'en_US.UTF-8', 04:06:12 INFO - 'LANGUAGE': 'en_US:en', 04:06:12 INFO - 'LOGNAME': 'cltbld', 04:06:12 INFO - 'MAIL': '/var/mail/cltbld', 04:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:12 INFO - 'MOZ_NO_REMOTE': '1', 04:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:12 INFO - 'NO_EM_RESTART': '1', 04:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:12 INFO - 'PWD': '/builds/slave/test', 04:06:12 INFO - 'SHELL': '/bin/bash', 04:06:12 INFO - 'SHLVL': '1', 04:06:12 INFO - 'TERM': 'linux', 04:06:12 INFO - 'TMOUT': '86400', 04:06:12 INFO - 'USER': 'cltbld', 04:06:12 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 04:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:12 INFO - '_': '/tools/buildbot/bin/python'} 04:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:12 INFO - Downloading/unpacking jsonschema 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:06:14 INFO - Downloading/unpacking functools32 (from jsonschema) 04:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:14 INFO - Downloading functools32-3.2.3-2.tar.gz 04:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:06:14 INFO - warning: no files found matching '*.txt' 04:06:14 INFO - no previously-included directories found matching 'build' 04:06:14 INFO - no previously-included directories found matching 'dist' 04:06:14 INFO - no previously-included directories found matching '.git*' 04:06:14 INFO - Installing collected packages: jsonschema, functools32 04:06:14 INFO - Running setup.py install for functools32 04:06:14 INFO - warning: no files found matching '*.txt' 04:06:14 INFO - no previously-included directories found matching 'build' 04:06:14 INFO - no previously-included directories found matching 'dist' 04:06:14 INFO - no previously-included directories found matching '.git*' 04:06:14 INFO - Successfully installed jsonschema functools32 04:06:14 INFO - Cleaning up... 04:06:14 INFO - Return code: 0 04:06:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec119ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15075a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1596410>, '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 0x1597310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15977a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:06:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:06:14 INFO - Using env: {'DISPLAY': ':0', 04:06:14 INFO - 'HOME': '/home/cltbld', 04:06:14 INFO - 'LANG': 'en_US.UTF-8', 04:06:14 INFO - 'LANGUAGE': 'en_US:en', 04:06:14 INFO - 'LOGNAME': 'cltbld', 04:06:14 INFO - 'MAIL': '/var/mail/cltbld', 04:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:14 INFO - 'MOZ_NO_REMOTE': '1', 04:06:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:14 INFO - 'NO_EM_RESTART': '1', 04:06:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:14 INFO - 'PWD': '/builds/slave/test', 04:06:14 INFO - 'SHELL': '/bin/bash', 04:06:14 INFO - 'SHLVL': '1', 04:06:14 INFO - 'TERM': 'linux', 04:06:14 INFO - 'TMOUT': '86400', 04:06:14 INFO - 'USER': 'cltbld', 04:06:14 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 04:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:14 INFO - '_': '/tools/buildbot/bin/python'} 04:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:15 INFO - Downloading/unpacking flake8 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:06:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:06:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:06:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:06:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:06:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:06:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:06:17 INFO - no previously-included directories found matching 'docs/_build' 04:06:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:06:17 INFO - Running setup.py install for pep8 04:06:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:06:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:06:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:06:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:06:17 INFO - no previously-included directories found matching 'docs/_build' 04:06:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:06:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:06:17 INFO - Cleaning up... 04:06:17 INFO - Return code: 0 04:06:17 INFO - Running post-action listener: _resource_record_post_action 04:06:17 INFO - Running post-action listener: _start_resource_monitoring 04:06:17 INFO - Starting resource monitoring. 04:06:17 INFO - ##### 04:06:17 INFO - ##### Running install step. 04:06:17 INFO - ##### 04:06:17 INFO - Running pre-action listener: _resource_record_pre_action 04:06:17 INFO - Running main action method: install 04:06:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:18 INFO - Reading from file tmpfile_stdout 04:06:18 INFO - Detecting whether we're running mozinstall >=1.0... 04:06:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:06:18 INFO - Reading from file tmpfile_stdout 04:06:18 INFO - Output received: 04:06:18 INFO - Usage: mozinstall [options] installer 04:06:18 INFO - Options: 04:06:18 INFO - -h, --help show this help message and exit 04:06:18 INFO - -d DEST, --destination=DEST 04:06:18 INFO - Directory to install application into. [default: 04:06:18 INFO - "/builds/slave/test"] 04:06:18 INFO - --app=APP Application being installed. [default: firefox] 04:06:18 INFO - mkdir: /builds/slave/test/build/application 04:06:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:06:33 INFO - Reading from file tmpfile_stdout 04:06:33 INFO - Output received: 04:06:33 INFO - /builds/slave/test/build/application/firefox/firefox 04:06:33 INFO - Running post-action listener: _resource_record_post_action 04:06:33 INFO - ##### 04:06:33 INFO - ##### Running run-tests step. 04:06:33 INFO - ##### 04:06:33 INFO - Running pre-action listener: _resource_record_pre_action 04:06:33 INFO - Running main action method: run_tests 04:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:06:33 INFO - Python 2.7.3 04:06:33 INFO - Return code: 0 04:06:33 INFO - grabbing minidump binary from tooltool 04:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:33 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 0x1596410>, '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 0x1597310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15977a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:06:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:06:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:06:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:06:33 INFO - Return code: 0 04:06:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:06:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:06:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:06:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:06:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:06:34 INFO - Return code: 0 04:06:34 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/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 04:06:34 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/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 04:06:34 INFO - Using env: {'DISPLAY': ':0', 04:06:34 INFO - 'HOME': '/home/cltbld', 04:06:34 INFO - 'LANG': 'en_US.UTF-8', 04:06:34 INFO - 'LANGUAGE': 'en_US:en', 04:06:34 INFO - 'LOGNAME': 'cltbld', 04:06:34 INFO - 'MAIL': '/var/mail/cltbld', 04:06:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:34 INFO - 'MOZ_NO_REMOTE': '1', 04:06:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:34 INFO - 'NO_EM_RESTART': '1', 04:06:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:34 INFO - 'PWD': '/builds/slave/test', 04:06:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:34 INFO - 'SHELL': '/bin/bash', 04:06:34 INFO - 'SHLVL': '1', 04:06:34 INFO - 'TERM': 'linux', 04:06:34 INFO - 'TMOUT': '86400', 04:06:34 INFO - 'USER': 'cltbld', 04:06:34 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745', 04:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:34 INFO - '_': '/tools/buildbot/bin/python'} 04:06:34 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/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 04:06:34 INFO - mozversion application_buildid: 20160510142413 04:06:34 INFO - mozversion application_changeset: 1dd42a351054c5b697873d647169019d4d77d762 04:06:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:06:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:06:34 INFO - mozversion application_name: Firefox 04:06:34 INFO - mozversion application_remotingname: firefox-dev 04:06:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:06:34 INFO - mozversion application_vendor: Mozilla 04:06:34 INFO - mozversion application_version: 48.0a2 04:06:34 INFO - mozversion platform_buildid: 20160510142413 04:06:34 INFO - mozversion platform_changeset: 1dd42a351054c5b697873d647169019d4d77d762 04:06:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:06:34 INFO - mozversion platform_version: 48.0a2 04:06:34 INFO - using testdate: 1462964794 04:06:34 INFO - actual date: 1462964794 04:06:34 INFO - starting webserver on 'localhost:48929' 04:06:34 INFO - SUITE-START | Running 2 tests 04:06:34 INFO - TEST-START | dromaeo_css 04:06:34 INFO - operating with platform_type : linux_ 04:06:34 INFO - Initialising browser for dromaeo_css test... 04:06:34 INFO - TEST-INFO | started process 25664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBQKzKO/profile http://localhost:48929/getInfo.html) 04:06:38 INFO - PROCESS | 25664 | 04:06:38 INFO - PROCESS | 25664 | (process:25742): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:06:39 INFO - PROCESS | 25664 | __metrics Screen width/height:1600/1200 04:06:39 INFO - PROCESS | 25664 | colorDepth:24 04:06:39 INFO - PROCESS | 25664 | Browser inner width/height: 1024/697 04:06:39 INFO - PROCESS | 25664 | __metrics 04:06:39 ERROR - PROCESS | 25664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:06:40 INFO - TEST-INFO | 25664: exit 0 04:06:40 INFO - Browser initialized. 04:06:40 INFO - Running cycle 1/1 for dromaeo_css test... 04:06:40 INFO - TEST-INFO | started process 25793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBQKzKO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:42 INFO - PROCESS | 25793 | 04:06:42 INFO - PROCESS | 25793 | (process:25862): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:06:52 INFO - PROCESS | 25793 | RSS: Main: 150880256 04:06:52 INFO - PROCESS | 25793 | 04:07:41 INFO - PROCESS | 25793 | 1462964861608 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:09:48 INFO - PROCESS | 25793 | Cycle 1(1): loaded http://localhost:48929/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48929/tests/dromaeo/cssquery-ext.html) 04:09:49 INFO - PROCESS | 25793 | RSS: Main: 154619904 04:09:49 INFO - PROCESS | 25793 | 04:12:51 INFO - PROCESS | 25793 | Cycle 1(1): loaded http://localhost:48929/tests/dromaeo/cssquery-ext.html (next: http://localhost:48929/tests/dromaeo/cssquery-jquery.html) 04:12:52 INFO - PROCESS | 25793 | RSS: Main: 153124864 04:12:52 INFO - PROCESS | 25793 | 04:15:54 INFO - PROCESS | 25793 | Cycle 1(1): loaded http://localhost:48929/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48929/tests/dromaeo/cssquery-mootools.html) 04:15:54 INFO - PROCESS | 25793 | RSS: Main: 151986176 04:15:54 INFO - PROCESS | 25793 | 04:18:56 INFO - PROCESS | 25793 | Cycle 1(1): loaded http://localhost:48929/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48929/tests/dromaeo/cssquery-prototype.html) 04:18:56 INFO - PROCESS | 25793 | RSS: Main: 151687168 04:18:56 INFO - PROCESS | 25793 | 04:21:59 INFO - PROCESS | 25793 | Cycle 1(1): loaded http://localhost:48929/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48929/tests/dromaeo/cssquery-yui.html) 04:21:59 INFO - PROCESS | 25793 | RSS: Main: 153071616 04:21:59 INFO - PROCESS | 25793 | 04:25:01 INFO - PROCESS | 25793 | Cycle 1(1): loaded http://localhost:48929/tests/dromaeo/cssquery-yui.html (next: http://localhost:48929/tests/dromaeo/cssquery-dojo.html) 04:25:02 INFO - PROCESS | 25793 | RSS: Main: 154238976 04:25:02 INFO - PROCESS | 25793 | 04:25:02 INFO - PROCESS | 25793 | __start_tp_report 04:25:02 INFO - PROCESS | 25793 | _x_x_mozilla_page_load 04:25:02 INFO - PROCESS | 25793 | _x_x_mozilla_page_load_details 04:25:02 INFO - PROCESS | 25793 | |i|pagename|runs| 04:25:02 INFO - PROCESS | 25793 | |0;dojo.html;3296.3901678189536;3296.4396052671045;3325.517799919013;3353.1281866714653;3368.4105281575735;5417.91873121903;5485.917711234335;5516;5525.972370138154;5534.474224948628;5500.5874559408;5520.089185284433;5534.861628459281;5544.500994910467;5561.277033985586;5038.521340472649;5043.848684539461;5112.488751124895;5117.078925793356;5119.616028797836;5044.19292913134;5140.4859514048485;5177.87055323618;5187.87030324243;5202.4277329493725;5059.342285502879;5125.487451254863;5131.820386286481;5140.742962851861;5162.690238585678;5184.377874655028;5202.0116177926075;5214.921776173361;5229.450907654717;5234.895302093937;4910.656254062217;5113.258577506241;5151.098557752378;5182.714950677711;5208.791648334062;5320.654157479751;5403.432639572867;5445.156000819879;5447.945520544784;5507.0637991541535;5935.6438613682885;5951.761929522857;5956.761729530814;5981.5214782817275;5990.371011043821;5912.704364781744;6016.578839481238;6045.12345709874;6078.696065196723;6084.787032453887;5574.498295153456;5654.886902261932;5671.716414179275;5679.375268720438;5704.201411802351;6072.149899014142;6108.236470441195;6115.235595550556;6125.816225513242;6131.049687298476;5711.9718450679275;5835.4748072673665;5847.56143289255;5869.64782113066;5889.381614930457;5859.736311865976;5888.205092312569;5892.175095486636;5906.970465147647;5949.375315591887;5815.244018277597;5831.4168583141345;5838.562107841929;5860.267466566679;5887.264091988502;5820.185174075633;5878.118282257696;5899.292084949748;5949.553783466257;5989.011813050798;4504.301833215857;4524.04994951064;4531.705439146445;4544.295634176708;4548.067646132535;4043.555208927016;4069.755814651071;4084.6528045116497;4096.651784598283;4128.298189307765;5571.554275657938;5700.401457846866;5774.88450230993;5782.913256301074;5800.216970708984;5806.88386232273;5870.412958704095;5913.379095195029;5921.940780592225;5970.791022314198;5680.4319568042865;5683.573731970118;5692.430756924275;5692.971535142297;5705.343885453143;4823.348847905558;4881.633877459205;4921.581665558396;4962.181240095416;5003.624728145403;6106.358832322542;6111.938880611226;6116.143739876421;6123.540734444934;6132.356102609251;5944.8811023780145;5975.52195824333;5989.970050149721;5993.190919226023;6000.639961602318;6089.451949324405;6175.3824617539685;6213.689315534296;6268.592541484789;6288.685565721604;5798.072308430631;5802.47777700009;5804.100364443518;5811.476967072815;5839.737211825393;5881.411858814085;5888.911666324922;5889.67606781614;5903.911441328298;5912.113183022581;5733.627314224562;5735.3977832327;5798.768049277982;5801.419858014165;5846.473817356458;5818.44724751148;5825.650460972355;5841.883162336644;5844.824655260349;5849.268841394825;5583.609147359646;5681.857953551029;5732.283464566929;5755.798547050833;5769.855753606025;5822.417758224144;5840.561957853093;5866.178734977192;5901.734421951109;5918.023526118142;5700.885982280414;5732.226149469769;5732.598718089694;5735.512481439125;5737.971310143423 04:25:02 INFO - PROCESS | 25793 | |1;ext.html;614.5759425996063;626.5426238845644;647.1102234427665;648.248032282552;664.0404615330842;37883.43174852376;38696.80651596738;38941.61058389415;38973.99999999996;39001.804990975004;39049;39839.60160398395;39861;39977;40013.19973600526;8529.189726975943;8664.133586641348;8702.608382622797;8704.303655707528;8717.041125476193;8580.313574913991;8653.783655408602;8920.375573709844;8923.107689231058;9046.3667543272;8703.738887833375;8724.956375218115;8731.519766412845;8753.474791512497;8771.473711577326;8865.06916773739;8914;8965.506897120657;8978.326625503048;9011.504367259799;8803.295736341077;8842.911570884273;8876.378653494257;8890.377673562853;8911.688090916787;36673.81663091668;39628.60371396278;40402.39396409056;40621.593784062374;40768.18463630711;3256.6580509046685;3614.963850361489;3662.7069834413182;3666.578343490506;3777.471154038437;27854.442911141865;28088.71911280902;28091.57862632062;28361.85819070912;30126.698733012607;4397.538258482878;4406.713563618387;4448.621867141264;4501.707389019703;4575.107853968478;244411;246806;247570;247779;247883;36336;37567;38231.808840955615;38430.61569384326;38778.418323725164;36835.81582092126;37044.814775925945;37048.07379815526;37067;37080.25839483195;16036.118013509136;16247.918760406123;16285.59286017859;16314.102724350274;16351.754723679154;14380.209088500233;14671.486497972519;14682;14710.705785884222;14731.189784561951;9069.727908162766;9112.81774364509;9133.908660913306;9179.082091790768;9228.538573071453;3476.7392445566684;3507.859685612598;3537.6816086552335;3571.5714114306447;3579.838907249128;1068.2201992545486;1094.4254266509986;1165.6969188011008;1179.33367647279;1186.7626474705094;32027.51958720621;32740.345193096004;33225.501617475755;33272.3345533088;33494;1211.54567037361;1229.4037391865118;1237.8205160251714;1281.923084614926;1355.5120156743565;16924.238409271613;17379.91310043467;17551.648967020843;17573.472795816146;17586.912065439592;441054;453019;477093;486618;496076;55909.161362579594;56238.43761562332;56713;56732.71633641805;56830;1505.6762795998693;1514.5834895403852;1520.3082597418147;1538.1155835394693;1611.0092293239807;30799.53800693036;33710.32579348448;33958.49062264118;34281;34710.13224669403;54340.18489722578;54495.18257226224;54687.72656136853;55333;55398;427374;428193;428843;429458;431723;30439.847800760854;30607.2348191297;30801;30876.22809429782;31188.37623247568;49544.50455495399;50111;50114;50662.49337506578;51193.23210151925;42784;43110.56889431066;43595.34606980961;43879;44327.55672443234;42933.57066429296;43265.567344326155;43750.124997500505;44029.77985110054;44230.11539769251;43677.78161109174;44488.39346358209;44506.777466112464;44798;45351.54648453473;36186.63813361938;36234.4564831533;36484;37045.259094818495;37222;28817.56773648355;28858.42283154367;29099.272518187216;29183;29367.55948660729 04:25:02 INFO - PROCESS | 25793 | |2;jquery.html;436.39341315571363;438.1018911231974;444.35124717911845;445.1386566992869;447.3002590157401;17968.37110701126;18227.908860455696;19032.42902712919;20040.49898752532;20052.498687532818;19595.118219680113;19813.702794458095;19942.202311907506;20409.183632654676;20460.69308960367;5771.192033115367;5794.333651630064;6027.849303767397;6031.215941927565;6036.8188954331445;5881.823545293627;5962.522998160137;5973.313068997056;5975.402459754012;5990.191324171225;5713.542916566665;5896.204012458306;5915.142304365864;5934.258217722785;5976.641401515902;5805.477507024346;5831.6209446386065;5845.269341332333;5882.264716910387;5889.411058894119;5301.913107812889;5337.759800808973;5571.9721401392735;5573.777048918038;5590.91613625796;22011.789351585816;23087.7691223089;23562.586244825194;23623;23703.881480592485;2415.4323733922515;2437.3541011631933;2714.8506832124226;2846.501862174132;2924.546695262238;9825.199818051893;9851.753706157404;9872.851907221397;9875.456849873253;10136.54385552652;1938.7673479182588;1953.6483432982056;1995.1420889017716;2074.1495986645555;2086.238522939116;75139.87290190652;76992.61503692501;77982;78633;78809;11384.487698053608;11739.354335511458;11754.471048802825;11837.112216583791;11886.643400697993;16145.515634530982;16215.189240537926;16229.2696828643;16251.187440628159;16402.753958690628;7918.802029949182;7960.920390796134;8130.959345203236;8163.469374490639;8218.589070546448;7665.118511371152;7682.846343073107;7704.383649308042;7777.066751989684;7777.533347999138;4454.799534020977;4496.898259926274;4723.385959825201;4959.7272150032095;5130.717810520383;1935.5161209697576;2053.866498677611;2066.411072844232;2096.287262330815;2150.752663443724;1008.5310330696261;1088.2871719024051;1146.340854008948;1148.8047032004579;1156.3928937307812;19297.228110875687;19400.708989365172;19574.70637940432;19727.60544789096;19909.61036892521;1108.2187058124002;1116.330201878866;1126.1328776841785;1128.7911736328806;1129.8079326514512;11069.169812264112;11165.274257173258;11169.329840209613;11249.83125253122;11316.660500185008;499669;519709;522492;526265;557965;48862.511374886504;52159.47840521622;56451.153232701545;72360;93425.06574934299;1094.6497120921388;1113.6492005018392;1118.765059337532;1123.8482804821408;1180.3272134883034;17884.374046908295;17967.910160449115;18230.72653910166;18537.44387668372;18578.25686972506;40674.38988415117;40872.18255634811;41419.1716165681;41930;42311.7884410576;51304;55375.16937246025;55774.44225557855;55783;55945;8634.352423568133;8853.73438796837;9060.95469522648;9124.817503650023;9210.355275130945;13247.138935969131;13941.093828901088;13994.16035037901;14047.859521405064;14131.293435328398;5794.652320860761;7510.699572017058;11678.6496405108;11829.231099978473;12167.148299618942;11522.423878806194;11523.13576481784;11628.186026978368;11672;11911.106666999836;11982.400879956142;12139;12367.134300598871;12449.25304481734;12533.248005119722;8146.266835984789;8526.531040792568;8555;8673.089325620718;8699.956500217459;11062.17033722458;11932.403379831147;12195.878041219474;12204.389780511117;12516.499340026297 04:25:02 INFO - PROCESS | 25793 | |3;mootools.html;1537.6463413414913;1546.9226538673067;1734.653069386123;1827.7715285589302;1849.704047352424;7140.28597140287;7735.651895664694;8102;8254.257116859482;8279.172082791718;7779.688812447495;7819.178986206452;7837.725679601201;7840.7255746048895;7871.409644276673;2253.1438053539673;2259.186692790594;2276.635738281875;2281;2285.3600991722346;2257.119723307911;2261.8642881427086;2293.1056887813766;2302.792748652621;2308.5267520158413;2261.977380226201;2272.9545409091807;2277.6925115109416;2282.589133955887;2300.1949317738827;2278.3392816083315;2296.47181148336;2306.6194077977116;2316.918907838226;2336.112277334602;2163.7619861815188;2167.512309730314;2179.3135162423946;2180.2478145039936;2181.073043956328;8172.18278172178;8176.550289734062;8182.427230093896;8207;8244.340452763825;5141.820036298749;5261.026710058613;5284.2866213061125;5300.522952934254;5303.814366497154;3361.2605226850055;3378;3521.0493166845063;3531.434970404723;3562.2341196642847;1185.1230089733535;1186.3534373766317;1249.3253643032751;1281.9936349965326;1285.6335944255843;11188.440577971069;11386.259893107004;11460.828087578693;11468.4839182237;11509.539618415338;4486.663500237495;4520.163769702615;4550.908981820345;4559.088182363541;4559.430071241095;9783.706488805346;9787.608495660237;9796.804063918682;9801.166900813369;9818.95090524557;5181.248718935733;5185;5191.195364718475;5203.843884683465;5210.661307015108;4236.809343579546;4662.813487460531;4704.411948506437;4723;4787.904241915142;4005.7396269242404;4127.174565086934;4154.709170358046;4160.521540022875;4174.019105510202;1316.42735410095;1356.010112617775;1363.3932899859665;1364.4542183126828;1376.3256004557695;885.2560455901863;984.5126662302206;1040.7606250562412;1062.3519653011656;1072.8498010278568;5691.601587888808;5860.853478663067;5867.559933005042;5878.735456904449;5911.970440147772;458.3331253026838;459.88272990387236;461.4324381011375;1086.380762965118;1110.4225802582612;3966.6033396660105;4057.594240575978;4096.119334343071;4096.877093687194;4124.072083781185;9406.858897116548;9655.613775449045;9662.468564228895;9668.129868311886;9679.322447428753;9298.302627302844;9528.285378596633;9582.760430989281;9587.472689002032;9598.66404675833;7876.56678882667;7881.133075361706;7919.802004949807;7928.801779955547;7951.5626640534165;5809.360970293349;5904.557158213237;5910.261217347832;5927.40725927421;6053.757849685963;9110.271178305587;9120;9154.633814647339;9196.26429885621;9309.255259579082;9094.636214551609;9371.625134994523;9394.577244023898;9450.149486545968;9503.477308748084;6487.253965793805;7094.9290507094265;7290.453216008715;7442.479026468095;7514.797632378793;7856.5678887661725;7891.131975482807;7953.244441778022;8002.7199048033035;8011.278984891388;6945.687444064928;7241.167265764505;7266.564006159648;7274.4907856449545;7394.704211831467;6912.619805910522;6931.861362772817;6941.47938904574;6966.512344135862;7184.9640751795905;6542.574732642363;6648.202215734143;6720.294369091175;6769.796906092825;6784.21981472137;5169.147090730138;5206.245094461357;5237.921431178459;5262.789488420421;5299.8410047698635;5035.496450354935;5035.597152227886;5108.438071812172;5132.820351287836;5157.8452646420665 04:25:02 INFO - PROCESS | 25793 | |4;prototype.html;348.07065136086646;348.5103429681298;354.28611348133506;355.7918617608699;358.8923323003098;6428.582142160756;6539.378759017897;6543.705533251009;6545.541812073151;6624.7350105995765;6345.619262844232;6348.873022539547;6456.192975878015;6503.894337962546;6527.673616319189;4881.975590122062;4917.459079501252;4932.728699921521;4935.876603084916;4942.135126352883;4941.975290123562;4949.579285760715;4951.183054795973;4959.008198360324;4968.503149685021;4894.412670479547;4900.411950565937;4923.458419573844;4929.408470983487;4933.950660493385;4886.438059623136;4887.071456423286;4892.6575139740235;4895.461499235082;4907.411110666707;4258.361245813153;4274.230638485072;4280.336547835091;4299.946513104278;4311.784410779448;6105.908411373833;6220.595661282002;6245.656488893109;6278.49772018242;6328.493720502349;5618.522425593829;5678.063119585264;5689.947359738461;5703.600747947646;5704.458076482728;6910.067140935959;6930.584164950119;6934.791956241321;6956.304369563054;6982.19704733957;4658.650601204923;4697.224957881979;4700.811967521295;4714.858554243378;4723.6929599575915;6902.137232845895;7181.928180718178;7208.171060328077;7208.495405321577;7234.5659260444545;4766.237402015661;4772.164871147535;4774.9972505773485;4802.135615589157;4817.927731084036;4839.370881785346;4852.296417019583;4862.149123903303;4883.926741098886;4885.340479035356;5596.160575913564;5628.915566266509;5633.324001119892;5658.236138121383;5666.4050274721385;6914.827129321707;6915.550489218184;6936.09830722013;6938.681650486392;6945.548539344926;1681.7225157849064;1683.1163639089332;1706.3089448773267;1708.4276767282852;1717.0041376001889;1086.4079076903106;1112.3881864974232;1116.938568378747;1120.8710998235144;1121.0527104596604;6663.566868153554;6676.9666151668935;6699;6715.294894036056;6726.831829204309;7096.396806271525;7269.382102521345;7271.963640181765;7282.8179295516975;7313.2321106284135;6751.797446076625;6798.456123510206;6810.6254156020905;6812.14848143982;6815.727370905208;3909.8240579174008;3913.1977944521304;3923.431102490123;3936.1143742658246;3940.0543869471694;7488.577170337619;7504.512206706547;7691.807704807313;7693.192214817475;7733.961330193426;7250.673719682627;7342.632868356561;7358.668859901317;7359.632018399058;7427.85144297111;7641.465097443237;7641.694332226649;7661.272179142972;7662.425318101276;7716.459847810712;7177.928220717726;7212.134543854771;7215.206327304098;7249.963750181215;7283.271672832674;7002.8949565757575;7128.108986376703;7138.464615153988;7139.07192065049;7163.462740294603;7528.736494222676;7531.472796904164;7556.168821429528;7573.810654733676;7614.923850761643;4708.270218116198;4712.222483290356;4751.643626728079;4765.0946320199055;4771.785269662804;7200.747973820891;7214.819629509304;7228.20489746138;7242;7251.311125443074;6890.758823441155;7008.194057683228;7029.402500787491;7031.964840175767;7090.858182836211;6908.3437073477935;6947.965260173667;6961.825954351182;6967.477439192182;6972.477064220102;6803.591784492946;6804.319568043156;6847.828804279933;6860.142482189726;6885.380315771605;7016.298370162943;7046.718131274692;7063.964680176772;7065.434765218873;7072.752453664097;6716.361945615159;6834.897476537955;6843.247242803188;6853.314668533107;6862.828429289308 04:25:02 INFO - PROCESS | 25793 | |5;yui.html;914.4604683236889;928.7678080479884;946.2571881073359;947.5546493148222;947.602007156994;15251.618709532268;15314.0811551307;15323.233838308095;15390.076595404284;15480.380784768624;14245.715085698279;14256.429742810275;14355.497557585486;14358.56924292273;14382.568522944328;880.9515476648797;897.9910200898005;904.421170450912;926.4950601921969;927.4574373991189;918.3296193778546;921.7465197070826;926.0507979321183;928.5032507608431;930.2743859789341;955.928305377096;958.396210387455;960;960.5437417226797;962.3888830592589;947.6967370441462;948.6347756113911;949.6106596295521;950.8811398575178;951.5052172870069;699.6361891816227;700.7687463137153;701.0640794539296;701.824543864034;704.503325155764;15770.842291577166;15802.288896999547;15884.285207165705;15894;16017.839821601752;14366.85633143676;14540;14596.781048284285;14671.853281467156;14711.337989790485;11848.822267665992;11942.46258918342;11965.222260553122;12024.939875300655;12165.087618428654;3947.46709194258;3963.564007959122;4026.45642838216;4050.7164498485117;4138.813753381075;57227.42772572263;57700;57715.13427298594;57900.131498027564;58148.41851581472;10911.890881091087;10961.12311015117;11044.889551104387;11193.16051296156;11815.940920295343;19738.40784776459;19862.205511779655;19909;19940.70088948667;19946.601067978558;8726.389152759373;8752.518611476302;9014.639414423349;9053.366264361563;9088.591013404413;4908.190148625436;5006.824761133415;5011.123053465629;5030.0945829751;5105.591552675777;3448.189675426273;3498.8775392861126;3528;3536.840842162109;3541.0793193769805;659.9010148477671;660.5409240577752;670.0351493848842;673.175360183771;681.0431343961742;750.6622020090981;793.7182300283432;795.3756301303565;828.1221904780951;842.6587232170981;9882.604695812232;9922.553485093189;9935.155511781435;9945.353552019096;10120.240981926385;646.4892734739597;740.174705203694;775.1899265267808;835.778518692547;858.3905427146796;4666.300054991779;4682.484926658065;4690.437147542249;4711.340412342275;4820.084184005028;65052;69304.3069569308;69329.65335173393;69546;69617.65191174012;58869.411305886395;59062;60747.392526075055;61442.692786536674;62421.37578624247;52662.47337526652;53497.46502534925;53549.73225133927;55012.44987550153;55044;8931;8961.23829474502;9008.279337653103;9152.007306516238;9271.072892710945;39276.607233927294;39798;39821.80089099536;39912.20175596414;41378.586214138675;48176;49292.753536233526;49657.255141173635;50231.23728194984;50769.23846142385;10526.157907367546;10661.200409969439;10958.616448424267;10999.23005389647;11094.833577496505;11713.121515886512;11938.820917686067;11940.46267917963;11991.340476273888;12181.451834667285;11909.166358354832;12148.149629525848;12189.390530473618;12202.755944880875;12865.935670321589;12048.397580121135;12518;12650.746985060063;12736;12750;12287.1399002069;12325.50697972071;12364.134510584172;12550.43523041447;12611.93694031524;10155.238357123097;10374.636887708893;10534;10569.101626361846;10755.462226888469;10581.418022008864;10796.730081748019;10943.343399396063;11052.563166788266;11206.607768728056 04:25:02 INFO - PROCESS | 25793 | __end_tp_report 04:25:02 INFO - PROCESS | 25793 | __start_cc_report 04:25:02 INFO - PROCESS | 25793 | _x_x_mozilla_cycle_collect,286 04:25:02 INFO - PROCESS | 25793 | __end_cc_report 04:25:02 INFO - PROCESS | 25793 | __startTimestamp1462965902032__endTimestamp 04:25:02 INFO - PROCESS | 25793 | 04:25:02 INFO - PROCESS | 25793 | ------- Summary: start ------- 04:25:02 INFO - PROCESS | 25793 | Number of tests: 6 04:25:02 INFO - PROCESS | 25793 | 04:25:02 INFO - PROCESS | 25793 | [#0] dojo.html Cycles:165 Average:5530.05 Median:5737.97 stddev:609.66 (10.6%) stddev-sans-first:585.81 04:25:02 INFO - PROCESS | 25793 | Values: 3296.4 3296.4 3325.5 3353.1 3368.4 5417.9 5485.9 5516.0 5526.0 5534.5 5500.6 5520.1 5534.9 5544.5 5561.3 5038.5 5043.8 5112.5 5117.1 5119.6 5044.2 5140.5 5177.9 5187.9 5202.4 5059.3 5125.5 5131.8 5140.7 5162.7 5184.4 5202.0 5214.9 5229.5 5234.9 4910.7 5113.3 5151.1 5182.7 5208.8 5320.7 5403.4 5445.2 5447.9 5507.1 5935.6 5951.8 5956.8 5981.5 5990.4 5912.7 6016.6 6045.1 6078.7 6084.8 5574.5 5654.9 5671.7 5679.4 5704.2 6072.1 6108.2 6115.2 6125.8 6131.0 5712.0 5835.5 5847.6 5869.6 5889.4 5859.7 5888.2 5892.2 5907.0 5949.4 5815.2 5831.4 5838.6 5860.3 5887.3 5820.2 5878.1 5899.3 5949.6 5989.0 4504.3 4524.0 4531.7 4544.3 4548.1 4043.6 4069.8 4084.7 4096.7 4128.3 5571.6 5700.4 5774.9 5782.9 5800.2 5806.9 5870.4 5913.4 5921.9 5970.8 5680.4 5683.6 5692.4 5693.0 5705.3 4823.3 4881.6 4921.6 4962.2 5003.6 6106.4 6111.9 6116.1 6123.5 6132.4 5944.9 5975.5 5990.0 5993.2 6000.6 6089.5 6175.4 6213.7 6268.6 6288.7 5798.1 5802.5 5804.1 5811.5 5839.7 5881.4 5888.9 5889.7 5903.9 5912.1 5733.6 5735.4 5798.8 5801.4 5846.5 5818.4 5825.7 5841.9 5844.8 5849.3 5583.6 5681.9 5732.3 5755.8 5769.9 5822.4 5840.6 5866.2 5901.7 5918.0 5700.9 5732.2 5732.6 5735.5 5738.0 04:25:02 INFO - PROCESS | 25793 | 04:25:02 INFO - PROCESS | 25793 | [#1] ext.html Cycles:180 Average:53950.31 Median:39025.40 stddev:104614.99 (268.1%) stddev-sans-first:104831.82 04:25:02 INFO - PROCESS | 25793 | Values: 614.6 626.5 647.1 648.2 664.0 37883.4 38696.8 38941.6 38974.0 39001.8 39049.0 39839.6 39861.0 39977.0 40013.2 8529.2 8664.1 8702.6 8704.3 8717.0 8580.3 8653.8 8920.4 8923.1 9046.4 8703.7 8725.0 8731.5 8753.5 8771.5 8865.1 8914.0 8965.5 8978.3 9011.5 8803.3 8842.9 8876.4 8890.4 8911.7 36673.8 39628.6 40402.4 40621.6 40768.2 3256.7 3615.0 3662.7 3666.6 3777.5 27854.4 28088.7 28091.6 28361.9 30126.7 4397.5 4406.7 4448.6 4501.7 4575.1 244411.0 246806.0 247570.0 247779.0 247883.0 36336.0 37567.0 38231.8 38430.6 38778.4 36835.8 37044.8 37048.1 37067.0 37080.3 16036.1 16247.9 16285.6 16314.1 16351.8 14380.2 14671.5 14682.0 14710.7 14731.2 9069.7 9112.8 9133.9 9179.1 9228.5 3476.7 3507.9 3537.7 3571.6 3579.8 1068.2 1094.4 1165.7 1179.3 1186.8 32027.5 32740.3 33225.5 33272.3 33494.0 1211.5 1229.4 1237.8 1281.9 1355.5 16924.2 17379.9 17551.6 17573.5 17586.9 441054.0 453019.0 477093.0 486618.0 496076.0 55909.2 56238.4 56713.0 56732.7 56830.0 1505.7 1514.6 1520.3 1538.1 1611.0 30799.5 33710.3 33958.5 34281.0 34710.1 54340.2 54495.2 54687.7 55333.0 55398.0 427374.0 428193.0 428843.0 429458.0 431723.0 30439.8 30607.2 30801.0 30876.2 31188.4 49544.5 50111.0 50114.0 50662.5 51193.2 42784.0 43110.6 43595.3 43879.0 44327.6 42933.6 43265.6 43750.1 44029.8 44230.1 43677.8 44488.4 44506.8 44798.0 45351.5 36186.6 36234.5 36484.0 37045.3 37222.0 28817.6 28858.4 29099.3 29183.0 29367.6 04:25:02 INFO - PROCESS | 25793 | 04:25:02 INFO - PROCESS | 25793 | [#2] jquery.html Cycles:180 Average:29170.86 Median:2576.10 stddev:85975.60 (3337.4%) stddev-sans-first:86189.71 04:25:02 INFO - PROCESS | 25793 | Values: 436.4 438.1 444.4 445.1 447.3 17968.4 18227.9 19032.4 20040.5 20052.5 19595.1 19813.7 19942.2 20409.2 20460.7 5771.2 5794.3 6027.8 6031.2 6036.8 5881.8 5962.5 5973.3 5975.4 5990.2 5713.5 5896.2 5915.1 5934.3 5976.6 5805.5 5831.6 5845.3 5882.3 5889.4 5301.9 5337.8 5572.0 5573.8 5590.9 22011.8 23087.8 23562.6 23623.0 23703.9 2415.4 2437.4 2714.9 2846.5 2924.5 9825.2 9851.8 9872.9 9875.5 10136.5 1938.8 1953.6 1995.1 2074.1 2086.2 75139.9 76992.6 77982.0 78633.0 78809.0 11384.5 11739.4 11754.5 11837.1 11886.6 16145.5 16215.2 16229.3 16251.2 16402.8 7918.8 7960.9 8131.0 8163.5 8218.6 7665.1 7682.8 7704.4 7777.1 7777.5 4454.8 4496.9 4723.4 4959.7 5130.7 1935.5 2053.9 2066.4 2096.3 2150.8 1008.5 1088.3 1146.3 1148.8 1156.4 19297.2 19400.7 19574.7 19727.6 19909.6 1108.2 1116.3 1126.1 1128.8 1129.8 11069.2 11165.3 11169.3 11249.8 11316.7 499669.0 519709.0 522492.0 526265.0 557965.0 48862.5 52159.5 56451.2 72360.0 93425.1 1094.6 1113.6 1118.8 1123.8 1180.3 17884.4 17967.9 18230.7 18537.4 18578.3 40674.4 40872.2 41419.2 41930.0 42311.8 51304.0 55375.2 55774.4 55783.0 55945.0 8634.4 8853.7 9061.0 9124.8 9210.4 13247.1 13941.1 13994.2 14047.9 14131.3 5794.7 7510.7 11678.6 11829.2 12167.1 11522.4 11523.1 11628.2 11672.0 11911.1 11982.4 12139.0 12367.1 12449.3 12533.2 8146.3 8526.5 8555.0 8673.1 8700.0 11062.2 11932.4 12195.9 12204.4 12516.5 04:25:02 INFO - PROCESS | 25793 | 04:25:02 INFO - PROCESS | 25793 | [#3] mootools.html Cycles:180 Average:5484.13 Median:5224.29 stddev:2946.38 (56.4%) stddev-sans-first:2939.72 04:25:02 INFO - PROCESS | 25793 | Values: 1537.6 1546.9 1734.7 1827.8 1849.7 7140.3 7735.7 8102.0 8254.3 8279.2 7779.7 7819.2 7837.7 7840.7 7871.4 2253.1 2259.2 2276.6 2281.0 2285.4 2257.1 2261.9 2293.1 2302.8 2308.5 2262.0 2273.0 2277.7 2282.6 2300.2 2278.3 2296.5 2306.6 2316.9 2336.1 2163.8 2167.5 2179.3 2180.2 2181.1 8172.2 8176.6 8182.4 8207.0 8244.3 5141.8 5261.0 5284.3 5300.5 5303.8 3361.3 3378.0 3521.0 3531.4 3562.2 1185.1 1186.4 1249.3 1282.0 1285.6 11188.4 11386.3 11460.8 11468.5 11509.5 4486.7 4520.2 4550.9 4559.1 4559.4 9783.7 9787.6 9796.8 9801.2 9819.0 5181.2 5185.0 5191.2 5203.8 5210.7 4236.8 4662.8 4704.4 4723.0 4787.9 4005.7 4127.2 4154.7 4160.5 4174.0 1316.4 1356.0 1363.4 1364.5 1376.3 885.3 984.5 1040.8 1062.4 1072.8 5691.6 5860.9 5867.6 5878.7 5912.0 458.3 459.9 461.4 1086.4 1110.4 3966.6 4057.6 4096.1 4096.9 4124.1 9406.9 9655.6 9662.5 9668.1 9679.3 9298.3 9528.3 9582.8 9587.5 9598.7 7876.6 7881.1 7919.8 7928.8 7951.6 5809.4 5904.6 5910.3 5927.4 6053.8 9110.3 9120.0 9154.6 9196.3 9309.3 9094.6 9371.6 9394.6 9450.1 9503.5 6487.3 7094.9 7290.5 7442.5 7514.8 7856.6 7891.1 7953.2 8002.7 8011.3 6945.7 7241.2 7266.6 7274.5 7394.7 6912.6 6931.9 6941.5 6966.5 7185.0 6542.6 6648.2 6720.3 6769.8 6784.2 5169.1 5206.2 5237.9 5262.8 5299.8 5035.5 5035.6 5108.4 5132.8 5157.8 04:25:02 INFO - PROCESS | 25793 | 04:25:02 INFO - PROCESS | 25793 | [#4] prototype.html Cycles:180 Average:5802.21 Median:6670.27 stddev:1797.96 (27.0%) stddev-sans-first:1755.78 04:25:02 INFO - PROCESS | 25793 | Values: 348.1 348.5 354.3 355.8 358.9 6428.6 6539.4 6543.7 6545.5 6624.7 6345.6 6348.9 6456.2 6503.9 6527.7 4882.0 4917.5 4932.7 4935.9 4942.1 4942.0 4949.6 4951.2 4959.0 4968.5 4894.4 4900.4 4923.5 4929.4 4934.0 4886.4 4887.1 4892.7 4895.5 4907.4 4258.4 4274.2 4280.3 4299.9 4311.8 6105.9 6220.6 6245.7 6278.5 6328.5 5618.5 5678.1 5689.9 5703.6 5704.5 6910.1 6930.6 6934.8 6956.3 6982.2 4658.7 4697.2 4700.8 4714.9 4723.7 6902.1 7181.9 7208.2 7208.5 7234.6 4766.2 4772.2 4775.0 4802.1 4817.9 4839.4 4852.3 4862.1 4883.9 4885.3 5596.2 5628.9 5633.3 5658.2 5666.4 6914.8 6915.6 6936.1 6938.7 6945.5 1681.7 1683.1 1706.3 1708.4 1717.0 1086.4 1112.4 1116.9 1120.9 1121.1 6663.6 6677.0 6699.0 6715.3 6726.8 7096.4 7269.4 7272.0 7282.8 7313.2 6751.8 6798.5 6810.6 6812.1 6815.7 3909.8 3913.2 3923.4 3936.1 3940.1 7488.6 7504.5 7691.8 7693.2 7734.0 7250.7 7342.6 7358.7 7359.6 7427.9 7641.5 7641.7 7661.3 7662.4 7716.5 7177.9 7212.1 7215.2 7250.0 7283.3 7002.9 7128.1 7138.5 7139.1 7163.5 7528.7 7531.5 7556.2 7573.8 7614.9 4708.3 4712.2 4751.6 4765.1 4771.8 7200.7 7214.8 7228.2 7242.0 7251.3 6890.8 7008.2 7029.4 7032.0 7090.9 6908.3 6948.0 6961.8 6967.5 6972.5 6803.6 6804.3 6847.8 6860.1 6885.4 7016.3 7046.7 7064.0 7065.4 7072.8 6716.4 6834.9 6843.2 6853.3 6862.8 04:25:02 INFO - PROCESS | 25793 | 04:25:02 INFO - PROCESS | 25793 | [#5] yui.html Cycles:180 Average:15774.27 Median:26498.04 stddev:18751.40 (70.8%) stddev-sans-first:18770.79 04:25:02 INFO - PROCESS | 25793 | Values: 914.5 928.8 946.3 947.6 947.6 15251.6 15314.1 15323.2 15390.1 15480.4 14245.7 14256.4 14355.5 14358.6 14382.6 881.0 898.0 904.4 926.5 927.5 918.3 921.7 926.1 928.5 930.3 955.9 958.4 960.0 960.5 962.4 947.7 948.6 949.6 950.9 951.5 699.6 700.8 701.1 701.8 704.5 15770.8 15802.3 15884.3 15894.0 16017.8 14366.9 14540.0 14596.8 14671.9 14711.3 11848.8 11942.5 11965.2 12024.9 12165.1 3947.5 3963.6 4026.5 4050.7 4138.8 57227.4 57700.0 57715.1 57900.1 58148.4 10911.9 10961.1 11044.9 11193.2 11815.9 19738.4 19862.2 19909.0 19940.7 19946.6 8726.4 8752.5 9014.6 9053.4 9088.6 4908.2 5006.8 5011.1 5030.1 5105.6 3448.2 3498.9 3528.0 3536.8 3541.1 659.9 660.5 670.0 673.2 681.0 750.7 793.7 795.4 828.1 842.7 9882.6 9922.6 9935.2 9945.4 10120.2 646.5 740.2 775.2 835.8 858.4 4666.3 4682.5 4690.4 4711.3 4820.1 65052.0 69304.3 69329.7 69546.0 69617.7 58869.4 59062.0 60747.4 61442.7 62421.4 52662.5 53497.5 53549.7 55012.4 55044.0 8931.0 8961.2 9008.3 9152.0 9271.1 39276.6 39798.0 39821.8 39912.2 41378.6 48176.0 49292.8 49657.3 50231.2 50769.2 10526.2 10661.2 10958.6 10999.2 11094.8 11713.1 11938.8 11940.5 11991.3 12181.5 11909.2 12148.1 12189.4 12202.8 12865.9 12048.4 12518.0 12650.7 12736.0 12750.0 12287.1 12325.5 12364.1 12550.4 12611.9 10155.2 10374.6 10534.0 10569.1 10755.5 10581.4 10796.7 10943.3 11052.6 11206.6 04:25:02 INFO - PROCESS | 25793 | -------- Summary: end -------- 04:25:02 INFO - PROCESS | 25793 | 04:25:02 INFO - TEST-INFO | 25793: exit 0 04:25:02 INFO - TEST-OK | dromaeo_css | took 1107492ms 04:25:02 INFO - TEST-START | kraken 04:25:02 INFO - operating with platform_type : linux_ 04:25:02 INFO - Initialising browser for kraken test... 04:25:02 INFO - TEST-INFO | started process 26039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc5hEwI/profile http://localhost:48929/getInfo.html) 04:25:05 INFO - PROCESS | 26039 | 04:25:05 INFO - PROCESS | 26039 | (process:26118): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:25:06 INFO - PROCESS | 26039 | __metrics Screen width/height:1600/1200 04:25:06 INFO - PROCESS | 26039 | colorDepth:24 04:25:06 INFO - PROCESS | 26039 | Browser inner width/height: 1024/697 04:25:06 INFO - PROCESS | 26039 | __metrics 04:25:07 ERROR - PROCESS | 26039 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:25:07 INFO - TEST-INFO | 26039: exit 0 04:25:07 INFO - Browser initialized. 04:25:07 INFO - Running cycle 1/1 for kraken test... 04:25:07 INFO - TEST-INFO | started process 26169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc5hEwI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:09 INFO - PROCESS | 26169 | 04:25:09 INFO - PROCESS | 26169 | (process:26240): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:25:19 INFO - PROCESS | 26169 | RSS: Main: 151367680 04:25:19 INFO - PROCESS | 26169 | 04:25:21 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:48929/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48929/tests/kraken/driver.html?testName=audio-beat-detection) 04:25:22 INFO - PROCESS | 26169 | RSS: Main: 155983872 04:25:22 INFO - PROCESS | 26169 | 04:25:24 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:48929/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48929/tests/kraken/driver.html?testName=audio-dft) 04:25:25 INFO - PROCESS | 26169 | RSS: Main: 155848704 04:25:25 INFO - PROCESS | 26169 | 04:25:28 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:48929/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48929/tests/kraken/driver.html?testName=audio-fft) 04:25:28 INFO - PROCESS | 26169 | RSS: Main: 156188672 04:25:28 INFO - PROCESS | 26169 | 04:25:31 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:48929/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48929/tests/kraken/driver.html?testName=audio-oscillator) 04:25:31 INFO - PROCESS | 26169 | RSS: Main: 156024832 04:25:31 INFO - PROCESS | 26169 | 04:25:33 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:48929/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48929/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:25:34 INFO - PROCESS | 26169 | RSS: Main: 156090368 04:25:34 INFO - PROCESS | 26169 | 04:25:37 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:48929/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48929/tests/kraken/driver.html?testName=imaging-darkroom) 04:25:38 INFO - PROCESS | 26169 | RSS: Main: 155877376 04:25:38 INFO - PROCESS | 26169 | 04:25:41 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:48929/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48929/tests/kraken/driver.html?testName=imaging-desaturate) 04:25:41 INFO - PROCESS | 26169 | RSS: Main: 156606464 04:25:41 INFO - PROCESS | 26169 | 04:25:44 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:48929/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48929/tests/kraken/driver.html?testName=json-parse-financial) 04:25:45 INFO - PROCESS | 26169 | RSS: Main: 156020736 04:25:45 INFO - PROCESS | 26169 | 04:25:46 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:48929/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48929/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:25:47 INFO - PROCESS | 26169 | RSS: Main: 156401664 04:25:47 INFO - PROCESS | 26169 | 04:25:49 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:48929/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48929/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:25:49 INFO - PROCESS | 26169 | RSS: Main: 155987968 04:25:49 INFO - PROCESS | 26169 | 04:25:51 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:48929/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48929/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:25:52 INFO - PROCESS | 26169 | RSS: Main: 156086272 04:25:52 INFO - PROCESS | 26169 | 04:25:54 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:48929/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:25:55 INFO - PROCESS | 26169 | RSS: Main: 156598272 04:25:55 INFO - PROCESS | 26169 | 04:25:58 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:48929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:25:58 INFO - PROCESS | 26169 | RSS: Main: 156823552 04:25:58 INFO - PROCESS | 26169 | 04:26:00 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:48929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48929/tests/kraken/driver.html?testName=ai-astar) 04:26:00 INFO - PROCESS | 26169 | RSS: Main: 158474240 04:26:00 INFO - PROCESS | 26169 | 04:26:00 INFO - PROCESS | 26169 | __start_tp_report 04:26:00 INFO - PROCESS | 26169 | _x_x_mozilla_page_load 04:26:00 INFO - PROCESS | 26169 | _x_x_mozilla_page_load_details 04:26:00 INFO - PROCESS | 26169 | |i|pagename|runs| 04:26:00 INFO - PROCESS | 26169 | |0;ai-astar;111;116;106;115;114;116;105;114;115;115 04:26:00 INFO - PROCESS | 26169 | |1;audio-beat-detection;157;136;158;172;134;155;158;134;174;136 04:26:00 INFO - PROCESS | 26169 | |2;audio-dft;165;165;164;164;166;163;164;162;163;165 04:26:00 INFO - PROCESS | 26169 | |3;audio-fft;77;79;79;169;78;76;79;80;166;76 04:26:00 INFO - PROCESS | 26169 | |4;audio-oscillator;93;93;141;94;95;94;137;93;94;139 04:26:00 INFO - PROCESS | 26169 | |5;imaging-gaussian-blur;119;119;119;119;119;118;119;120;119;118 04:26:00 INFO - PROCESS | 26169 | |6;imaging-darkroom;149;148;148;148;148;148;148;148;149;149 04:26:00 INFO - PROCESS | 26169 | |7;imaging-desaturate;97;96;96;95;97;97;97;95;96;97 04:26:00 INFO - PROCESS | 26169 | |8;json-parse-financial;54;56;56;56;57;56;56;67;55;55 04:26:00 INFO - PROCESS | 26169 | |9;json-stringify-tinderbox;60;58;58;58;58;59;59;59;59;61 04:26:00 INFO - PROCESS | 26169 | |10;stanford-crypto-aes;78;75;82;76;76;76;82;77;79;76 04:26:00 INFO - PROCESS | 26169 | |11;stanford-crypto-ccm;120;131;119;121;122;128;116;122;138;145 04:26:00 INFO - PROCESS | 26169 | |12;stanford-crypto-pbkdf2;168;167;167;169;164;168;162;161;164;161 04:26:00 INFO - PROCESS | 26169 | |13;stanford-crypto-sha256-iterative;69;65;68;68;71;68;67;68;66;67 04:26:00 INFO - PROCESS | 26169 | __end_tp_report 04:26:00 INFO - PROCESS | 26169 | __start_cc_report 04:26:00 INFO - PROCESS | 26169 | _x_x_mozilla_cycle_collect,748 04:26:00 INFO - PROCESS | 26169 | __end_cc_report 04:26:00 INFO - PROCESS | 26169 | __startTimestamp1462965960520__endTimestamp 04:26:00 INFO - PROCESS | 26169 | 04:26:00 INFO - PROCESS | 26169 | ------- Summary: start ------- 04:26:00 INFO - PROCESS | 26169 | Number of tests: 14 04:26:00 INFO - PROCESS | 26169 | 04:26:00 INFO - PROCESS | 26169 | [#0] ai-astar Cycles:10 Average:112.70 Median:115.00 stddev:4.06 (3.5%) stddev-sans-first:4.26 04:26:00 INFO - PROCESS | 26169 | Values: 111.0 116.0 106.0 115.0 114.0 116.0 105.0 114.0 115.0 115.0 04:26:00 INFO - PROCESS | 26169 | 04:26:00 INFO - PROCESS | 26169 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:157.50 stddev:15.44 (9.8%) stddev-sans-first:16.25 04:26:00 INFO - PROCESS | 26169 | Values: 157.0 136.0 158.0 172.0 134.0 155.0 158.0 134.0 174.0 136.0 04:26:00 INFO - PROCESS | 26169 | 04:26:00 INFO - PROCESS | 26169 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.50 stddev:1.20 (0.7%) stddev-sans-first:1.22 04:26:00 INFO - PROCESS | 26169 | Values: 165.0 165.0 164.0 164.0 166.0 163.0 164.0 162.0 163.0 165.0 04:26:00 INFO - PROCESS | 26169 | 04:26:00 INFO - PROCESS | 26169 | [#3] audio-fft Cycles:10 Average:95.90 Median:78.50 stddev:37.77 (48.1%) stddev-sans-first:39.43 04:26:00 INFO - PROCESS | 26169 | Values: 77.0 79.0 79.0 169.0 78.0 76.0 79.0 80.0 166.0 76.0 04:26:00 INFO - PROCESS | 26169 | 04:26:00 INFO - PROCESS | 26169 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:93.50 stddev:21.90 (23.4%) stddev-sans-first:22.61 04:26:00 INFO - PROCESS | 26169 | Values: 93.0 93.0 141.0 94.0 95.0 94.0 137.0 93.0 94.0 139.0 04:26:00 INFO - PROCESS | 26169 | 04:26:00 INFO - PROCESS | 26169 | [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:119.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:26:00 INFO - PROCESS | 26169 | Values: 119.0 119.0 119.0 119.0 119.0 118.0 119.0 120.0 119.0 118.0 04:26:00 INFO - PROCESS | 26169 | 04:26:00 INFO - PROCESS | 26169 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 04:26:00 INFO - PROCESS | 26169 | Values: 149.0 148.0 148.0 148.0 148.0 148.0 148.0 148.0 149.0 149.0 04:26:00 INFO - PROCESS | 26169 | 04:26:00 INFO - PROCESS | 26169 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.83 04:26:00 INFO - PROCESS | 26169 | Values: 97.0 96.0 96.0 95.0 97.0 97.0 97.0 95.0 96.0 97.0 04:26:00 INFO - PROCESS | 26169 | 04:26:00 INFO - PROCESS | 26169 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.00 stddev:3.68 (6.6%) stddev-sans-first:3.76 04:26:00 INFO - PROCESS | 26169 | Values: 54.0 56.0 56.0 56.0 57.0 56.0 56.0 67.0 55.0 55.0 04:26:00 INFO - PROCESS | 26169 | 04:26:00 INFO - PROCESS | 26169 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.99 (1.7%) stddev-sans-first:0.97 04:26:00 INFO - PROCESS | 26169 | Values: 60.0 58.0 58.0 58.0 58.0 59.0 59.0 59.0 59.0 61.0 04:26:00 INFO - PROCESS | 26169 | 04:26:00 INFO - PROCESS | 26169 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:77.50 stddev:2.54 (3.3%) stddev-sans-first:2.69 04:26:00 INFO - PROCESS | 26169 | Values: 78.0 75.0 82.0 76.0 76.0 76.0 82.0 77.0 79.0 76.0 04:26:00 INFO - PROCESS | 26169 | 04:26:00 INFO - PROCESS | 26169 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:125.00 stddev:9.28 (7.4%) stddev-sans-first:9.57 04:26:00 INFO - PROCESS | 26169 | Values: 120.0 131.0 119.0 121.0 122.0 128.0 116.0 122.0 138.0 145.0 04:26:00 INFO - PROCESS | 26169 | 04:26:00 INFO - PROCESS | 26169 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:167.00 stddev:3.07 (1.8%) stddev-sans-first:3.07 04:26:00 INFO - PROCESS | 26169 | Values: 168.0 167.0 167.0 169.0 164.0 168.0 162.0 161.0 164.0 161.0 04:26:00 INFO - PROCESS | 26169 | 04:26:00 INFO - PROCESS | 26169 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.64 (2.4%) stddev-sans-first:1.67 04:26:00 INFO - PROCESS | 26169 | Values: 69.0 65.0 68.0 68.0 71.0 68.0 67.0 68.0 66.0 67.0 04:26:00 INFO - PROCESS | 26169 | -------- Summary: end -------- 04:26:00 INFO - PROCESS | 26169 | 04:26:01 INFO - TEST-INFO | 26169: exit 0 04:26:01 INFO - TEST-OK | kraken | took 58808ms 04:26:01 INFO - SUITE-END | took 1166s 04:26:01 INFO - Completed test suite (00:19:26) 04:26:01 INFO - javascript benchmark 04:26:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3296.3901678189536, 3296.4396052671045, 3325.517799919013, 3353.1281866714653, 3368.4105281575735, 5417.91873121903, 5485.917711234335, 5516.0, 5525.972370138154, 5534.474224948628, 5500.5874559408, 5520.089185284433, 5534.861628459281, 5544.500994910467, 5561.277033985586, 5038.521340472649, 5043.848684539461, 5112.488751124895, 5117.078925793356, 5119.616028797836, 5044.19292913134, 5140.4859514048485, 5177.87055323618, 5187.87030324243, 5202.4277329493725, 5059.342285502879, 5125.487451254863, 5131.820386286481, 5140.742962851861, 5162.690238585678, 5184.377874655028, 5202.0116177926075, 5214.921776173361, 5229.450907654717, 5234.895302093937, 4910.656254062217, 5113.258577506241, 5151.098557752378, 5182.714950677711, 5208.791648334062, 5320.654157479751, 5403.432639572867, 5445.156000819879, 5447.945520544784, 5507.0637991541535, 5935.6438613682885, 5951.761929522857, 5956.761729530814, 5981.5214782817275, 5990.371011043821, 5912.704364781744, 6016.578839481238, 6045.12345709874, 6078.696065196723, 6084.787032453887, 5574.498295153456, 5654.886902261932, 5671.716414179275, 5679.375268720438, 5704.201411802351, 6072.149899014142, 6108.236470441195, 6115.235595550556, 6125.816225513242, 6131.049687298476, 5711.9718450679275, 5835.4748072673665, 5847.56143289255, 5869.64782113066, 5889.381614930457, 5859.736311865976, 5888.205092312569, 5892.175095486636, 5906.970465147647, 5949.375315591887, 5815.244018277597, 5831.4168583141345, 5838.562107841929, 5860.267466566679, 5887.264091988502, 5820.185174075633, 5878.118282257696, 5899.292084949748, 5949.553783466257, 5989.011813050798, 4504.301833215857, 4524.04994951064, 4531.705439146445, 4544.295634176708, 4548.067646132535, 4043.555208927016, 4069.755814651071, 4084.6528045116497, 4096.651784598283, 4128.298189307765, 5571.554275657938, 5700.401457846866, 5774.88450230993, 5782.913256301074, 5800.216970708984, 5806.88386232273, 5870.412958704095, 5913.379095195029, 5921.940780592225, 5970.791022314198, 5680.4319568042865, 5683.573731970118, 5692.430756924275, 5692.971535142297, 5705.343885453143, 4823.348847905558, 4881.633877459205, 4921.581665558396, 4962.181240095416, 5003.624728145403, 6106.358832322542, 6111.938880611226, 6116.143739876421, 6123.540734444934, 6132.356102609251, 5944.8811023780145, 5975.52195824333, 5989.970050149721, 5993.190919226023, 6000.639961602318, 6089.451949324405, 6175.3824617539685, 6213.689315534296, 6268.592541484789, 6288.685565721604, 5798.072308430631, 5802.47777700009, 5804.100364443518, 5811.476967072815, 5839.737211825393, 5881.411858814085, 5888.911666324922, 5889.67606781614, 5903.911441328298, 5912.113183022581, 5733.627314224562, 5735.3977832327, 5798.768049277982, 5801.419858014165, 5846.473817356458, 5818.44724751148, 5825.650460972355, 5841.883162336644, 5844.824655260349, 5849.268841394825, 5583.609147359646, 5681.857953551029, 5732.283464566929, 5755.798547050833, 5769.855753606025, 5822.417758224144, 5840.561957853093, 5866.178734977192, 5901.734421951109, 5918.023526118142, 5700.885982280414, 5732.226149469769, 5732.598718089694, 5735.512481439125, 5737.971310143423], "value": 5490.514207451092, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.5759425996063, 626.5426238845644, 647.1102234427665, 648.248032282552, 664.0404615330842, 37883.43174852376, 38696.80651596738, 38941.61058389415, 38973.99999999996, 39001.804990975004, 39049.0, 39839.60160398395, 39861.0, 39977.0, 40013.19973600526, 8529.189726975943, 8664.133586641348, 8702.608382622797, 8704.303655707528, 8717.041125476193, 8580.313574913991, 8653.783655408602, 8920.375573709844, 8923.107689231058, 9046.3667543272, 8703.738887833375, 8724.956375218115, 8731.519766412845, 8753.474791512497, 8771.473711577326, 8865.06916773739, 8914.0, 8965.506897120657, 8978.326625503048, 9011.504367259799, 8803.295736341077, 8842.911570884273, 8876.378653494257, 8890.377673562853, 8911.688090916787, 36673.81663091668, 39628.60371396278, 40402.39396409056, 40621.593784062374, 40768.18463630711, 3256.6580509046685, 3614.963850361489, 3662.7069834413182, 3666.578343490506, 3777.471154038437, 27854.442911141865, 28088.71911280902, 28091.57862632062, 28361.85819070912, 30126.698733012607, 4397.538258482878, 4406.713563618387, 4448.621867141264, 4501.707389019703, 4575.107853968478, 244411.0, 246806.0, 247570.0, 247779.0, 247883.0, 36336.0, 37567.0, 38231.808840955615, 38430.61569384326, 38778.418323725164, 36835.81582092126, 37044.814775925945, 37048.07379815526, 37067.0, 37080.25839483195, 16036.118013509136, 16247.918760406123, 16285.59286017859, 16314.102724350274, 16351.754723679154, 14380.209088500233, 14671.486497972519, 14682.0, 14710.705785884222, 14731.189784561951, 9069.727908162766, 9112.81774364509, 9133.908660913306, 9179.082091790768, 9228.538573071453, 3476.7392445566684, 3507.859685612598, 3537.6816086552335, 3571.5714114306447, 3579.838907249128, 1068.2201992545486, 1094.4254266509986, 1165.6969188011008, 1179.33367647279, 1186.7626474705094, 32027.51958720621, 32740.345193096004, 33225.501617475755, 33272.3345533088, 33494.0, 1211.54567037361, 1229.4037391865118, 1237.8205160251714, 1281.923084614926, 1355.5120156743565, 16924.238409271613, 17379.91310043467, 17551.648967020843, 17573.472795816146, 17586.912065439592, 441054.0, 453019.0, 477093.0, 486618.0, 496076.0, 55909.161362579594, 56238.43761562332, 56713.0, 56732.71633641805, 56830.0, 1505.6762795998693, 1514.5834895403852, 1520.3082597418147, 1538.1155835394693, 1611.0092293239807, 30799.53800693036, 33710.32579348448, 33958.49062264118, 34281.0, 34710.13224669403, 54340.18489722578, 54495.18257226224, 54687.72656136853, 55333.0, 55398.0, 427374.0, 428193.0, 428843.0, 429458.0, 431723.0, 30439.847800760854, 30607.2348191297, 30801.0, 30876.22809429782, 31188.37623247568, 49544.50455495399, 50111.0, 50114.0, 50662.49337506578, 51193.23210151925, 42784.0, 43110.56889431066, 43595.34606980961, 43879.0, 44327.55672443234, 42933.57066429296, 43265.567344326155, 43750.124997500505, 44029.77985110054, 44230.11539769251, 43677.78161109174, 44488.39346358209, 44506.777466112464, 44798.0, 45351.54648453473, 36186.63813361938, 36234.4564831533, 36484.0, 37045.259094818495, 37222.0, 28817.56773648355, 28858.42283154367, 29099.272518187216, 29183.0, 29367.55948660729], "value": 18924.055373176318, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.39341315571363, 438.1018911231974, 444.35124717911845, 445.1386566992869, 447.3002590157401, 17968.37110701126, 18227.908860455696, 19032.42902712919, 20040.49898752532, 20052.498687532818, 19595.118219680113, 19813.702794458095, 19942.202311907506, 20409.183632654676, 20460.69308960367, 5771.192033115367, 5794.333651630064, 6027.849303767397, 6031.215941927565, 6036.8188954331445, 5881.823545293627, 5962.522998160137, 5973.313068997056, 5975.402459754012, 5990.191324171225, 5713.542916566665, 5896.204012458306, 5915.142304365864, 5934.258217722785, 5976.641401515902, 5805.477507024346, 5831.6209446386065, 5845.269341332333, 5882.264716910387, 5889.411058894119, 5301.913107812889, 5337.759800808973, 5571.9721401392735, 5573.777048918038, 5590.91613625796, 22011.789351585816, 23087.7691223089, 23562.586244825194, 23623.0, 23703.881480592485, 2415.4323733922515, 2437.3541011631933, 2714.8506832124226, 2846.501862174132, 2924.546695262238, 9825.199818051893, 9851.753706157404, 9872.851907221397, 9875.456849873253, 10136.54385552652, 1938.7673479182588, 1953.6483432982056, 1995.1420889017716, 2074.1495986645555, 2086.238522939116, 75139.87290190652, 76992.61503692501, 77982.0, 78633.0, 78809.0, 11384.487698053608, 11739.354335511458, 11754.471048802825, 11837.112216583791, 11886.643400697993, 16145.515634530982, 16215.189240537926, 16229.2696828643, 16251.187440628159, 16402.753958690628, 7918.802029949182, 7960.920390796134, 8130.959345203236, 8163.469374490639, 8218.589070546448, 7665.118511371152, 7682.846343073107, 7704.383649308042, 7777.066751989684, 7777.533347999138, 4454.799534020977, 4496.898259926274, 4723.385959825201, 4959.7272150032095, 5130.717810520383, 1935.5161209697576, 2053.866498677611, 2066.411072844232, 2096.287262330815, 2150.752663443724, 1008.5310330696261, 1088.2871719024051, 1146.340854008948, 1148.8047032004579, 1156.3928937307812, 19297.228110875687, 19400.708989365172, 19574.70637940432, 19727.60544789096, 19909.61036892521, 1108.2187058124002, 1116.330201878866, 1126.1328776841785, 1128.7911736328806, 1129.8079326514512, 11069.169812264112, 11165.274257173258, 11169.329840209613, 11249.83125253122, 11316.660500185008, 499669.0, 519709.0, 522492.0, 526265.0, 557965.0, 48862.511374886504, 52159.47840521622, 56451.153232701545, 72360.0, 93425.06574934299, 1094.6497120921388, 1113.6492005018392, 1118.765059337532, 1123.8482804821408, 1180.3272134883034, 17884.374046908295, 17967.910160449115, 18230.72653910166, 18537.44387668372, 18578.25686972506, 40674.38988415117, 40872.18255634811, 41419.1716165681, 41930.0, 42311.7884410576, 51304.0, 55375.16937246025, 55774.44225557855, 55783.0, 55945.0, 8634.352423568133, 8853.73438796837, 9060.95469522648, 9124.817503650023, 9210.355275130945, 13247.138935969131, 13941.093828901088, 13994.16035037901, 14047.859521405064, 14131.293435328398, 5794.652320860761, 7510.699572017058, 11678.6496405108, 11829.231099978473, 12167.148299618942, 11522.423878806194, 11523.13576481784, 11628.186026978368, 11672.0, 11911.106666999836, 11982.400879956142, 12139.0, 12367.134300598871, 12449.25304481734, 12533.248005119722, 8146.266835984789, 8526.531040792568, 8555.0, 8673.089325620718, 8699.956500217459, 11062.17033722458, 11932.403379831147, 12195.878041219474, 12204.389780511117, 12516.499340026297], "value": 9372.793355940017, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.6463413414913, 1546.9226538673067, 1734.653069386123, 1827.7715285589302, 1849.704047352424, 7140.28597140287, 7735.651895664694, 8102.0, 8254.257116859482, 8279.172082791718, 7779.688812447495, 7819.178986206452, 7837.725679601201, 7840.7255746048895, 7871.409644276673, 2253.1438053539673, 2259.186692790594, 2276.635738281875, 2281.0, 2285.3600991722346, 2257.119723307911, 2261.8642881427086, 2293.1056887813766, 2302.792748652621, 2308.5267520158413, 2261.977380226201, 2272.9545409091807, 2277.6925115109416, 2282.589133955887, 2300.1949317738827, 2278.3392816083315, 2296.47181148336, 2306.6194077977116, 2316.918907838226, 2336.112277334602, 2163.7619861815188, 2167.512309730314, 2179.3135162423946, 2180.2478145039936, 2181.073043956328, 8172.18278172178, 8176.550289734062, 8182.427230093896, 8207.0, 8244.340452763825, 5141.820036298749, 5261.026710058613, 5284.2866213061125, 5300.522952934254, 5303.814366497154, 3361.2605226850055, 3378.0, 3521.0493166845063, 3531.434970404723, 3562.2341196642847, 1185.1230089733535, 1186.3534373766317, 1249.3253643032751, 1281.9936349965326, 1285.6335944255843, 11188.440577971069, 11386.259893107004, 11460.828087578693, 11468.4839182237, 11509.539618415338, 4486.663500237495, 4520.163769702615, 4550.908981820345, 4559.088182363541, 4559.430071241095, 9783.706488805346, 9787.608495660237, 9796.804063918682, 9801.166900813369, 9818.95090524557, 5181.248718935733, 5185.0, 5191.195364718475, 5203.843884683465, 5210.661307015108, 4236.809343579546, 4662.813487460531, 4704.411948506437, 4723.0, 4787.904241915142, 4005.7396269242404, 4127.174565086934, 4154.709170358046, 4160.521540022875, 4174.019105510202, 1316.42735410095, 1356.010112617775, 1363.3932899859665, 1364.4542183126828, 1376.3256004557695, 885.2560455901863, 984.5126662302206, 1040.7606250562412, 1062.3519653011656, 1072.8498010278568, 5691.601587888808, 5860.853478663067, 5867.559933005042, 5878.735456904449, 5911.970440147772, 458.3331253026838, 459.88272990387236, 461.4324381011375, 1086.380762965118, 1110.4225802582612, 3966.6033396660105, 4057.594240575978, 4096.119334343071, 4096.877093687194, 4124.072083781185, 9406.858897116548, 9655.613775449045, 9662.468564228895, 9668.129868311886, 9679.322447428753, 9298.302627302844, 9528.285378596633, 9582.760430989281, 9587.472689002032, 9598.66404675833, 7876.56678882667, 7881.133075361706, 7919.802004949807, 7928.801779955547, 7951.5626640534165, 5809.360970293349, 5904.557158213237, 5910.261217347832, 5927.40725927421, 6053.757849685963, 9110.271178305587, 9120.0, 9154.633814647339, 9196.26429885621, 9309.255259579082, 9094.636214551609, 9371.625134994523, 9394.577244023898, 9450.149486545968, 9503.477308748084, 6487.253965793805, 7094.9290507094265, 7290.453216008715, 7442.479026468095, 7514.797632378793, 7856.5678887661725, 7891.131975482807, 7953.244441778022, 8002.7199048033035, 8011.278984891388, 6945.687444064928, 7241.167265764505, 7266.564006159648, 7274.4907856449545, 7394.704211831467, 6912.619805910522, 6931.861362772817, 6941.47938904574, 6966.512344135862, 7184.9640751795905, 6542.574732642363, 6648.202215734143, 6720.294369091175, 6769.796906092825, 6784.21981472137, 5169.147090730138, 5206.245094461357, 5237.921431178459, 5262.789488420421, 5299.8410047698635, 5035.496450354935, 5035.597152227886, 5108.438071812172, 5132.820351287836, 5157.8452646420665], "value": 4468.85271473332, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.07065136086646, 348.5103429681298, 354.28611348133506, 355.7918617608699, 358.8923323003098, 6428.582142160756, 6539.378759017897, 6543.705533251009, 6545.541812073151, 6624.7350105995765, 6345.619262844232, 6348.873022539547, 6456.192975878015, 6503.894337962546, 6527.673616319189, 4881.975590122062, 4917.459079501252, 4932.728699921521, 4935.876603084916, 4942.135126352883, 4941.975290123562, 4949.579285760715, 4951.183054795973, 4959.008198360324, 4968.503149685021, 4894.412670479547, 4900.411950565937, 4923.458419573844, 4929.408470983487, 4933.950660493385, 4886.438059623136, 4887.071456423286, 4892.6575139740235, 4895.461499235082, 4907.411110666707, 4258.361245813153, 4274.230638485072, 4280.336547835091, 4299.946513104278, 4311.784410779448, 6105.908411373833, 6220.595661282002, 6245.656488893109, 6278.49772018242, 6328.493720502349, 5618.522425593829, 5678.063119585264, 5689.947359738461, 5703.600747947646, 5704.458076482728, 6910.067140935959, 6930.584164950119, 6934.791956241321, 6956.304369563054, 6982.19704733957, 4658.650601204923, 4697.224957881979, 4700.811967521295, 4714.858554243378, 4723.6929599575915, 6902.137232845895, 7181.928180718178, 7208.171060328077, 7208.495405321577, 7234.5659260444545, 4766.237402015661, 4772.164871147535, 4774.9972505773485, 4802.135615589157, 4817.927731084036, 4839.370881785346, 4852.296417019583, 4862.149123903303, 4883.926741098886, 4885.340479035356, 5596.160575913564, 5628.915566266509, 5633.324001119892, 5658.236138121383, 5666.4050274721385, 6914.827129321707, 6915.550489218184, 6936.09830722013, 6938.681650486392, 6945.548539344926, 1681.7225157849064, 1683.1163639089332, 1706.3089448773267, 1708.4276767282852, 1717.0041376001889, 1086.4079076903106, 1112.3881864974232, 1116.938568378747, 1120.8710998235144, 1121.0527104596604, 6663.566868153554, 6676.9666151668935, 6699.0, 6715.294894036056, 6726.831829204309, 7096.396806271525, 7269.382102521345, 7271.963640181765, 7282.8179295516975, 7313.2321106284135, 6751.797446076625, 6798.456123510206, 6810.6254156020905, 6812.14848143982, 6815.727370905208, 3909.8240579174008, 3913.1977944521304, 3923.431102490123, 3936.1143742658246, 3940.0543869471694, 7488.577170337619, 7504.512206706547, 7691.807704807313, 7693.192214817475, 7733.961330193426, 7250.673719682627, 7342.632868356561, 7358.668859901317, 7359.632018399058, 7427.85144297111, 7641.465097443237, 7641.694332226649, 7661.272179142972, 7662.425318101276, 7716.459847810712, 7177.928220717726, 7212.134543854771, 7215.206327304098, 7249.963750181215, 7283.271672832674, 7002.8949565757575, 7128.108986376703, 7138.464615153988, 7139.07192065049, 7163.462740294603, 7528.736494222676, 7531.472796904164, 7556.168821429528, 7573.810654733676, 7614.923850761643, 4708.270218116198, 4712.222483290356, 4751.643626728079, 4765.0946320199055, 4771.785269662804, 7200.747973820891, 7214.819629509304, 7228.20489746138, 7242.0, 7251.311125443074, 6890.758823441155, 7008.194057683228, 7029.402500787491, 7031.964840175767, 7090.858182836211, 6908.3437073477935, 6947.965260173667, 6961.825954351182, 6967.477439192182, 6972.477064220102, 6803.591784492946, 6804.319568043156, 6847.828804279933, 6860.142482189726, 6885.380315771605, 7016.298370162943, 7046.718131274692, 7063.964680176772, 7065.434765218873, 7072.752453664097, 6716.361945615159, 6834.897476537955, 6843.247242803188, 6853.314668533107, 6862.828429289308], "value": 5207.972866431435, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [914.4604683236889, 928.7678080479884, 946.2571881073359, 947.5546493148222, 947.602007156994, 15251.618709532268, 15314.0811551307, 15323.233838308095, 15390.076595404284, 15480.380784768624, 14245.715085698279, 14256.429742810275, 14355.497557585486, 14358.56924292273, 14382.568522944328, 880.9515476648797, 897.9910200898005, 904.421170450912, 926.4950601921969, 927.4574373991189, 918.3296193778546, 921.7465197070826, 926.0507979321183, 928.5032507608431, 930.2743859789341, 955.928305377096, 958.396210387455, 960.0, 960.5437417226797, 962.3888830592589, 947.6967370441462, 948.6347756113911, 949.6106596295521, 950.8811398575178, 951.5052172870069, 699.6361891816227, 700.7687463137153, 701.0640794539296, 701.824543864034, 704.503325155764, 15770.842291577166, 15802.288896999547, 15884.285207165705, 15894.0, 16017.839821601752, 14366.85633143676, 14540.0, 14596.781048284285, 14671.853281467156, 14711.337989790485, 11848.822267665992, 11942.46258918342, 11965.222260553122, 12024.939875300655, 12165.087618428654, 3947.46709194258, 3963.564007959122, 4026.45642838216, 4050.7164498485117, 4138.813753381075, 57227.42772572263, 57700.0, 57715.13427298594, 57900.131498027564, 58148.41851581472, 10911.890881091087, 10961.12311015117, 11044.889551104387, 11193.16051296156, 11815.940920295343, 19738.40784776459, 19862.205511779655, 19909.0, 19940.70088948667, 19946.601067978558, 8726.389152759373, 8752.518611476302, 9014.639414423349, 9053.366264361563, 9088.591013404413, 4908.190148625436, 5006.824761133415, 5011.123053465629, 5030.0945829751, 5105.591552675777, 3448.189675426273, 3498.8775392861126, 3528.0, 3536.840842162109, 3541.0793193769805, 659.9010148477671, 660.5409240577752, 670.0351493848842, 673.175360183771, 681.0431343961742, 750.6622020090981, 793.7182300283432, 795.3756301303565, 828.1221904780951, 842.6587232170981, 9882.604695812232, 9922.553485093189, 9935.155511781435, 9945.353552019096, 10120.240981926385, 646.4892734739597, 740.174705203694, 775.1899265267808, 835.778518692547, 858.3905427146796, 4666.300054991779, 4682.484926658065, 4690.437147542249, 4711.340412342275, 4820.084184005028, 65052.0, 69304.3069569308, 69329.65335173393, 69546.0, 69617.65191174012, 58869.411305886395, 59062.0, 60747.392526075055, 61442.692786536674, 62421.37578624247, 52662.47337526652, 53497.46502534925, 53549.73225133927, 55012.44987550153, 55044.0, 8931.0, 8961.23829474502, 9008.279337653103, 9152.007306516238, 9271.072892710945, 39276.607233927294, 39798.0, 39821.80089099536, 39912.20175596414, 41378.586214138675, 48176.0, 49292.753536233526, 49657.255141173635, 50231.23728194984, 50769.23846142385, 10526.157907367546, 10661.200409969439, 10958.616448424267, 10999.23005389647, 11094.833577496505, 11713.121515886512, 11938.820917686067, 11940.46267917963, 11991.340476273888, 12181.451834667285, 11909.166358354832, 12148.149629525848, 12189.390530473618, 12202.755944880875, 12865.935670321589, 12048.397580121135, 12518.0, 12650.746985060063, 12736.0, 12750.0, 12287.1399002069, 12325.50697972071, 12364.134510584172, 12550.43523041447, 12611.93694031524, 10155.238357123097, 10374.636887708893, 10534.0, 10569.101626361846, 10755.462226888469, 10581.418022008864, 10796.730081748019, 10943.343399396063, 11052.563166788266, 11206.607768728056], "value": 7145.917653973036, "unit": "score"}], "name": "dromaeo_css", "value": 7383.166069098777, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 106.0, 115.0, 114.0, 116.0, 105.0, 114.0, 115.0, 115.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 136.0, 158.0, 172.0, 134.0, 155.0, 158.0, 134.0, 174.0, 136.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 164.0, 164.0, 166.0, 163.0, 164.0, 162.0, 163.0, 165.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 79.0, 169.0, 78.0, 76.0, 79.0, 80.0, 166.0, 76.0], "value": 95.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 141.0, 94.0, 95.0, 94.0, 137.0, 93.0, 94.0, 139.0], "value": 107.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 119.0, 119.0, 119.0, 118.0, 119.0, 120.0, 119.0, 118.0], "value": 118.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 149.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 95.0, 97.0, 97.0, 97.0, 95.0, 96.0, 97.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 56.0, 56.0, 57.0, 56.0, 56.0, 67.0, 55.0, 55.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 58.0, 58.0, 58.0, 59.0, 59.0, 59.0, 59.0, 61.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 82.0, 76.0, 76.0, 76.0, 82.0, 77.0, 79.0, 76.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 131.0, 119.0, 121.0, 122.0, 128.0, 116.0, 122.0, 138.0, 145.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 167.0, 169.0, 164.0, 168.0, 162.0, 161.0, 164.0, 161.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 68.0, 68.0, 71.0, 68.0, 67.0, 68.0, 66.0, 67.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1547.3, "alertThreshold": 2.0}]} 04:26:01 INFO - Return code: 0 04:26:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:26:01 ERROR - # TBPL SUCCESS # 04:26:01 INFO - Running post-action listener: _resource_record_post_action 04:26:01 INFO - Running post-run listener: _resource_record_post_run 04:26:02 INFO - Total resource usage - Wall time: 1183s; CPU: 25.0%; Read bytes: 4096; Write bytes: 499359744; Read time: 20; Write time: 548896 04:26:02 INFO - install - Wall time: 16s; CPU: 28.0%; Read bytes: 0; Write bytes: 258895872; Read time: 0; Write time: 337552 04:26:02 INFO - run-tests - Wall time: 1168s; CPU: 25.0%; Read bytes: 4096; Write bytes: 239865856; Read time: 20; Write time: 211344 04:26:02 INFO - Running post-run listener: _upload_blobber_files 04:26:02 INFO - Blob upload gear active. 04:26:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:26:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:26:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:26:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:26:03 INFO - (blobuploader) - INFO - Open directory for files ... 04:26:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:26:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:26:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:03 INFO - (blobuploader) - INFO - Done attempting. 04:26:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:26:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:26:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:05 INFO - (blobuploader) - INFO - Done attempting. 04:26:05 INFO - (blobuploader) - INFO - Iteration through files over. 04:26:05 INFO - Return code: 0 04:26:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:26:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:26:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21573b92a5fb4afafd3f1c824b721c9b2e3d055d3c5ed43dd685cbcde0c480685e45be3cd0250882073286ea47100b0021ff5ee49caa4d2a9ad9c3ce08669f6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3249b279f03f83493bcce298537923bd88a80b5a32dc395c155e54f0c3d3ab62a29b4f2e18485f6db591650188472be43b76a60fc50367bba21b82a8e857161"} 04:26:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:26:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:26:05 INFO - Contents: 04:26:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21573b92a5fb4afafd3f1c824b721c9b2e3d055d3c5ed43dd685cbcde0c480685e45be3cd0250882073286ea47100b0021ff5ee49caa4d2a9ad9c3ce08669f6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3249b279f03f83493bcce298537923bd88a80b5a32dc395c155e54f0c3d3ab62a29b4f2e18485f6db591650188472be43b76a60fc50367bba21b82a8e857161"} 04:26:05 INFO - Running post-run listener: copy_logs_to_upload_dir 04:26:05 INFO - Copying logs to upload dir... 04:26:05 INFO - mkdir: /builds/slave/test/build/upload/logs 04:26:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1219.273400 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 19 secs) (at 2016-05-11 04:26:04.550414) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 04:26:04.557923) ========= 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=14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745 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/21573b92a5fb4afafd3f1c824b721c9b2e3d055d3c5ed43dd685cbcde0c480685e45be3cd0250882073286ea47100b0021ff5ee49caa4d2a9ad9c3ce08669f6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3249b279f03f83493bcce298537923bd88a80b5a32dc395c155e54f0c3d3ab62a29b4f2e18485f6db591650188472be43b76a60fc50367bba21b82a8e857161"} build_url:https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005342 build_url: 'https://queue.taskcluster.net/v1/task/EuDmtBLcROetm4hlT3PX0Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21573b92a5fb4afafd3f1c824b721c9b2e3d055d3c5ed43dd685cbcde0c480685e45be3cd0250882073286ea47100b0021ff5ee49caa4d2a9ad9c3ce08669f6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3249b279f03f83493bcce298537923bd88a80b5a32dc395c155e54f0c3d3ab62a29b4f2e18485f6db591650188472be43b76a60fc50367bba21b82a8e857161"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 04:26:04.576031) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:26:04.576380) ========= 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=14ef55db36f7623abb31b9cf000001d5-1462964715.463885-1971457745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002161 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:26:04.655347) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 04:26:04.658711) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 04:26:04.658994) ========= ========= Total master_lag: 0.17 =========