builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-044 starttime: 1461583421.04 results: success (0) buildid: 20160425025650 builduid: 8feaf5f08b7749f383ae9c3ff5224e44 revision: 1c6385ae1fe7e37d8f23f958ce14582f07af729e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 04:23:41.042470) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 04:23:41.042937) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 04:23:41.043214) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 04:23:41.060205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:23:41.060500) ========= 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=574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 04:23:41-- 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% 218M=0s 2016-04-25 04:23:41 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109849 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:23:41.185792) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:23:41.186344) ========= 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=574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016455 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:23:41.236606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:23:41.236983) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1c6385ae1fe7e37d8f23f958ce14582f07af729e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1c6385ae1fe7e37d8f23f958ce14582f07af729e --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=574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 04:23:41,787 truncating revision to first 12 chars 2016-04-25 04:23:41,787 Setting DEBUG logging. 2016-04-25 04:23:41,787 attempt 1/10 2016-04-25 04:23:41,787 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1c6385ae1fe7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 04:23:42,050 unpacking tar archive at: mozilla-central-1c6385ae1fe7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.576211 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:23:41.825869) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 04:23:41.826193) ========= script_repo_revision: 1c6385ae1fe7e37d8f23f958ce14582f07af729e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 04:23:41.826730) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 04:23:41.827003) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 04:23:41.835493) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-25 04:23:41.835878) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:23:42 INFO - MultiFileLogger online at 20160425 04:23:42 in /builds/slave/test 04:23:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:23:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:23:42 INFO - {'append_to_log': False, 04:23:42 INFO - 'base_work_dir': '/builds/slave/test', 04:23:42 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:23:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:23:42 INFO - 'branch': 'Firefox-Non-PGO', 04:23:42 INFO - 'buildbot_json_path': 'buildprops.json', 04:23:42 INFO - 'config_files': ('talos/linux_config.py',), 04:23:42 INFO - 'default_actions': ('clobber', 04:23:42 INFO - 'read-buildbot-config', 04:23:42 INFO - 'download-and-extract', 04:23:42 INFO - 'populate-webroot', 04:23:42 INFO - 'create-virtualenv', 04:23:42 INFO - 'install', 04:23:42 INFO - 'run-tests'), 04:23:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:23:42 INFO - 'download_minidump_stackwalk': True, 04:23:42 INFO - 'download_symbols': 'ondemand', 04:23:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:23:42 INFO - 'tooltool.py': '/tools/tooltool.py', 04:23:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:23:42 INFO - '/tools/misc-python/virtualenv.py')}, 04:23:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:23:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:23:42 INFO - 'installer_path': 'installer.exe', 04:23:42 INFO - 'log_level': 'info', 04:23:42 INFO - 'log_name': 'talos', 04:23:42 INFO - 'log_to_console': True, 04:23:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:23:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:23:42 INFO - 'opt_config_files': (), 04:23:42 INFO - 'pip_index': False, 04:23:42 INFO - 'sps_profile': False, 04:23:42 INFO - 'sps_profile_interval': 0, 04:23:42 INFO - 'suite': 'dromaeojs', 04:23:42 INFO - 'system_bits': '32', 04:23:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:23:42 INFO - 'title': 'talos-linux64-ix-044', 04:23:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:23:42 INFO - 'use_talos_json': True, 04:23:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:23:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:23:42 INFO - 'work_dir': 'build'} 04:23:42 INFO - ##### 04:23:42 INFO - ##### Running clobber step. 04:23:42 INFO - ##### 04:23:42 INFO - Running pre-action listener: _resource_record_pre_action 04:23:42 INFO - Running main action method: clobber 04:23:42 INFO - rmtree: /builds/slave/test/build 04:23:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:23:43 INFO - Running post-action listener: _resource_record_post_action 04:23:43 INFO - ##### 04:23:43 INFO - ##### Running read-buildbot-config step. 04:23:43 INFO - ##### 04:23:43 INFO - Running pre-action listener: _resource_record_pre_action 04:23:43 INFO - Running main action method: read_buildbot_config 04:23:43 INFO - Using buildbot properties: 04:23:43 INFO - { 04:23:43 INFO - "project": "", 04:23:43 INFO - "product": "firefox", 04:23:43 INFO - "script_repo_revision": "production", 04:23:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:23:43 INFO - "repository": "", 04:23:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:23:43 INFO - "buildid": "20160425025650", 04:23:43 INFO - "pgo_build": "False", 04:23:43 INFO - "basedir": "/builds/slave/test", 04:23:43 INFO - "buildnumber": 76, 04:23:43 INFO - "slavename": "talos-linux64-ix-044", 04:23:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:23:43 INFO - "platform": "ubuntu64_hw", 04:23:43 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:23:43 INFO - "branch": "mozilla-central", 04:23:43 INFO - "repo_path": "mozilla-central", 04:23:43 INFO - "revision": "1c6385ae1fe7e37d8f23f958ce14582f07af729e", 04:23:43 INFO - "stage_platform": "linux64", 04:23:43 INFO - "builduid": "8feaf5f08b7749f383ae9c3ff5224e44", 04:23:43 INFO - "slavebuilddir": "test" 04:23:43 INFO - } 04:23:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:23:43 INFO - Running post-action listener: _resource_record_post_action 04:23:43 INFO - ##### 04:23:43 INFO - ##### Running download-and-extract step. 04:23:43 INFO - ##### 04:23:43 INFO - Running pre-action listener: _resource_record_pre_action 04:23:43 INFO - Running main action method: download_and_extract 04:23:43 INFO - mkdir: /builds/slave/test/build/tests 04:23:43 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:23:43 INFO - https://queue.taskcluster.net/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:23:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:23:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:23:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:23:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:23:43 INFO - Downloaded 1361 bytes. 04:23:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:23:43 INFO - Using the following test package requirements: 04:23:43 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:23:43 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:23:43 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:23:43 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:43 INFO - u'jsshell-linux-x86_64.zip'], 04:23:43 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:23:43 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:23:43 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:23:43 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:23:43 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:23:43 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:23:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:23:43 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:23:43 INFO - https://queue.taskcluster.net/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:23:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:23:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:23:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:23:45 INFO - Downloaded 22287736 bytes. 04:23:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:23:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:23:46 INFO - Return code: 0 04:23:46 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:23: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:23:46 INFO - https://queue.taskcluster.net/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:23:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:23:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:23:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:23:47 INFO - Downloaded 22287736 bytes. 04:23:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:23:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:23:49 INFO - Return code: 0 04:23: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:23:49 INFO - https://queue.taskcluster.net/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:23:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:23:50 INFO - Downloaded 10840145 bytes. 04:23:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:23:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:23:50 INFO - Return code: 0 04:23:50 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:23:50 INFO - https://queue.taskcluster.net/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:23:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:23:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:23:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:23:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:23:52 INFO - Downloaded 54811070 bytes. 04:23:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:23:52 INFO - mkdir: /builds/slave/test/properties 04:23:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:23:52 INFO - Writing to file /builds/slave/test/properties/build_url 04:23:52 INFO - Contents: 04:23:52 INFO - build_url:https://queue.taskcluster.net/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:23:53 INFO - Running post-action listener: _resource_record_post_action 04:23:53 INFO - Running post-action listener: set_extra_try_arguments 04:23:53 INFO - ##### 04:23:53 INFO - ##### Running populate-webroot step. 04:23:53 INFO - ##### 04:23:53 INFO - Running pre-action listener: _resource_record_pre_action 04:23:53 INFO - Running main action method: populate_webroot 04:23:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:23:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:23:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:23:53 INFO - '--tppagecycles', 04:23:53 INFO - '7'], 04:23:53 INFO - 'tests': ['tsvgm']}}, 04:23:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:23:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:23:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:23:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:23:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:23:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:23:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:53 INFO - 'talos_options': ['--disable-e10s'], 04:23:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:53 INFO - 'talos_options': ['--disable-e10s'], 04:23:53 INFO - 'tests': ['damp', 'tps']}, 04:23:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:53 INFO - 'tests': ['damp', 'tps']}, 04:23:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:23:53 INFO - 'tests': ['dromaeo_dom']}, 04:23:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:23:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:23:53 INFO - 'tests': ['a11yr', 04:23:53 INFO - 'ts_paint', 04:23:53 INFO - 'tpaint', 04:23:53 INFO - 'sessionrestore', 04:23:53 INFO - 'sessionrestore_no_auto_restore', 04:23:53 INFO - 'tabpaint']}, 04:23:53 INFO - 'other-e10s': {'tests': ['a11yr', 04:23:53 INFO - 'ts_paint', 04:23:53 INFO - 'tpaint', 04:23:53 INFO - 'sessionrestore', 04:23:53 INFO - 'sessionrestore_no_auto_restore', 04:23:53 INFO - 'tabpaint']}, 04:23:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:23:53 INFO - 'ts_paint', 04:23:53 INFO - 'tpaint', 04:23:53 INFO - 'sessionrestore', 04:23:53 INFO - 'sessionrestore_no_auto_restore', 04:23:53 INFO - 'tabpaint']}, 04:23:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:23:53 INFO - 'ts_paint', 04:23:53 INFO - 'tpaint', 04:23:53 INFO - 'sessionrestore', 04:23:53 INFO - 'sessionrestore_no_auto_restore', 04:23:53 INFO - 'tabpaint']}, 04:23:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:23:53 INFO - 'tests': ['a11yr', 04:23:53 INFO - 'ts_paint', 04:23:53 INFO - 'tpaint', 04:23:53 INFO - 'sessionrestore', 04:23:53 INFO - 'sessionrestore_no_auto_restore', 04:23:53 INFO - 'tabpaint']}, 04:23:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:23:53 INFO - 'tests': ['a11yr', 04:23:53 INFO - 'ts_paint', 04:23:53 INFO - 'tpaint', 04:23:53 INFO - 'sessionrestore', 04:23:53 INFO - 'sessionrestore_no_auto_restore', 04:23:53 INFO - 'tabpaint']}, 04:23:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:23:53 INFO - 'tests': ['tsvgx', 04:23:53 INFO - 'tsvgr_opacity', 04:23:53 INFO - 'tart', 04:23:53 INFO - 'tscrollx', 04:23:53 INFO - 'cart']}, 04:23:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:23:53 INFO - 'tsvgr_opacity', 04:23:53 INFO - 'tart', 04:23:53 INFO - 'tscrollx', 04:23:53 INFO - 'cart']}, 04:23:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:53 INFO - 'talos_options': ['--disable-e10s'], 04:23:53 INFO - 'tests': ['tp5o']}, 04:23:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:53 INFO - 'tests': ['tp5o']}, 04:23:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:53 INFO - 'talos_options': ['--disable-e10s', 04:23:53 INFO - '--xperf_path', 04:23:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:53 INFO - 'tests': ['tp5n']}, 04:23:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:53 INFO - 'talos_options': ['--xperf_path', 04:23:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:53 INFO - 'tests': ['tp5n']}}, 04:23:53 INFO - 'talos.zip': {'path': '', 04:23:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:23:53 INFO - Running post-action listener: _resource_record_post_action 04:23:53 INFO - ##### 04:23:53 INFO - ##### Running create-virtualenv step. 04:23:53 INFO - ##### 04:23:53 INFO - Running pre-action listener: _resource_record_pre_action 04:23:53 INFO - Running main action method: create_virtualenv 04:23:53 INFO - Creating virtualenv /builds/slave/test/build/venv 04:23:53 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:23:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:23:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:23:53 INFO - Using real prefix '/usr' 04:23:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:23:54 INFO - Installing distribute.............................................................................................................................................................................................done. 04:23:56 INFO - Installing pip.................done. 04:23:56 INFO - Return code: 0 04:23:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:23:56 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:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:56 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:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:56 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 0x7f624943bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2120410>, '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 0x2121310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21217a0>, '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': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', '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:23:56 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:23:56 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:23:56 INFO - Using env: {'DISPLAY': ':0', 04:23:56 INFO - 'HOME': '/home/cltbld', 04:23:56 INFO - 'LANG': 'en_US.UTF-8', 04:23:56 INFO - 'LANGUAGE': 'en_US:en', 04:23:56 INFO - 'LOGNAME': 'cltbld', 04:23:56 INFO - 'MAIL': '/var/mail/cltbld', 04:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:56 INFO - 'MOZ_NO_REMOTE': '1', 04:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:56 INFO - 'NO_EM_RESTART': '1', 04:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:56 INFO - 'PWD': '/builds/slave/test', 04:23:56 INFO - 'SHELL': '/bin/bash', 04:23:56 INFO - 'SHLVL': '1', 04:23:56 INFO - 'TERM': 'linux', 04:23:56 INFO - 'TMOUT': '86400', 04:23:56 INFO - 'USER': 'cltbld', 04:23:56 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', 04:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:56 INFO - '_': '/tools/buildbot/bin/python'} 04:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:56 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:23:56 INFO - Cleaning up... 04:23:56 INFO - Return code: 0 04:23:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:23:56 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:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:56 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:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:56 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 0x7f624943bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2120410>, '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 0x2121310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21217a0>, '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': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', '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:23:56 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:23:56 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:23:56 INFO - Using env: {'DISPLAY': ':0', 04:23:56 INFO - 'HOME': '/home/cltbld', 04:23:56 INFO - 'LANG': 'en_US.UTF-8', 04:23:56 INFO - 'LANGUAGE': 'en_US:en', 04:23:56 INFO - 'LOGNAME': 'cltbld', 04:23:56 INFO - 'MAIL': '/var/mail/cltbld', 04:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:56 INFO - 'MOZ_NO_REMOTE': '1', 04:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:56 INFO - 'NO_EM_RESTART': '1', 04:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:56 INFO - 'PWD': '/builds/slave/test', 04:23:56 INFO - 'SHELL': '/bin/bash', 04:23:56 INFO - 'SHLVL': '1', 04:23:56 INFO - 'TERM': 'linux', 04:23:56 INFO - 'TMOUT': '86400', 04:23:56 INFO - 'USER': 'cltbld', 04:23:56 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', 04:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:56 INFO - '_': '/tools/buildbot/bin/python'} 04:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:56 INFO - Downloading/unpacking psutil>=0.7.1 04:23:56 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:23:56 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:23:56 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:23:56 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:23:56 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:23:56 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:23:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:23:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:58 INFO - Installing collected packages: psutil 04:23:58 INFO - Running setup.py install for psutil 04:23:58 INFO - building 'psutil._psutil_linux' extension 04:23:58 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:23:58 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:23:58 INFO - building 'psutil._psutil_posix' extension 04:23:58 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:23:59 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:23:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:59 INFO - Successfully installed psutil 04:23:59 INFO - Cleaning up... 04:23:59 INFO - Return code: 0 04:23:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f624943bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2120410>, '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 0x2121310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21217a0>, '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': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', '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:23:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:23:59 INFO - Using env: {'DISPLAY': ':0', 04:23:59 INFO - 'HOME': '/home/cltbld', 04:23:59 INFO - 'LANG': 'en_US.UTF-8', 04:23:59 INFO - 'LANGUAGE': 'en_US:en', 04:23:59 INFO - 'LOGNAME': 'cltbld', 04:23:59 INFO - 'MAIL': '/var/mail/cltbld', 04:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:59 INFO - 'MOZ_NO_REMOTE': '1', 04:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:59 INFO - 'NO_EM_RESTART': '1', 04:23:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:59 INFO - 'PWD': '/builds/slave/test', 04:23:59 INFO - 'SHELL': '/bin/bash', 04:23:59 INFO - 'SHLVL': '1', 04:23:59 INFO - 'TERM': 'linux', 04:23:59 INFO - 'TMOUT': '86400', 04:23:59 INFO - 'USER': 'cltbld', 04:23:59 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', 04:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:59 INFO - '_': '/tools/buildbot/bin/python'} 04:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:23:59 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:23:59 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:23:59 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:23:59 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:23:59 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:23:59 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:24:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:24:01 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:24:01 INFO - Installing collected packages: mozsystemmonitor 04:24:01 INFO - Running setup.py install for mozsystemmonitor 04:24:01 INFO - Successfully installed mozsystemmonitor 04:24:01 INFO - Cleaning up... 04:24:01 INFO - Return code: 0 04:24:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f624943bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2120410>, '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 0x2121310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21217a0>, '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': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', '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:24:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:24:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:24:01 INFO - Using env: {'DISPLAY': ':0', 04:24:01 INFO - 'HOME': '/home/cltbld', 04:24:01 INFO - 'LANG': 'en_US.UTF-8', 04:24:01 INFO - 'LANGUAGE': 'en_US:en', 04:24:01 INFO - 'LOGNAME': 'cltbld', 04:24:01 INFO - 'MAIL': '/var/mail/cltbld', 04:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:01 INFO - 'MOZ_NO_REMOTE': '1', 04:24:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:01 INFO - 'NO_EM_RESTART': '1', 04:24:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:01 INFO - 'PWD': '/builds/slave/test', 04:24:01 INFO - 'SHELL': '/bin/bash', 04:24:01 INFO - 'SHLVL': '1', 04:24:01 INFO - 'TERM': 'linux', 04:24:01 INFO - 'TMOUT': '86400', 04:24:01 INFO - 'USER': 'cltbld', 04:24:01 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', 04:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:01 INFO - '_': '/tools/buildbot/bin/python'} 04:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:01 INFO - Downloading/unpacking blobuploader==1.2.4 04:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:03 INFO - Downloading blobuploader-1.2.4.tar.gz 04:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:24:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:24:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:24: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:24: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:24: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:24: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:24: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:24: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:24:04 INFO - Downloading docopt-0.6.1.tar.gz 04:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:24:04 INFO - Installing collected packages: blobuploader, requests, docopt 04:24:04 INFO - Running setup.py install for blobuploader 04:24:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:24:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:24:04 INFO - Running setup.py install for requests 04:24:04 INFO - Running setup.py install for docopt 04:24:04 INFO - Successfully installed blobuploader requests docopt 04:24:04 INFO - Cleaning up... 04:24:04 INFO - Return code: 0 04:24:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:04 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 0x7f624943bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2120410>, '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 0x2121310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21217a0>, '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': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', '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:24:04 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:24:04 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:24:04 INFO - Using env: {'DISPLAY': ':0', 04:24:04 INFO - 'HOME': '/home/cltbld', 04:24:04 INFO - 'LANG': 'en_US.UTF-8', 04:24:04 INFO - 'LANGUAGE': 'en_US:en', 04:24:04 INFO - 'LOGNAME': 'cltbld', 04:24:04 INFO - 'MAIL': '/var/mail/cltbld', 04:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:04 INFO - 'MOZ_NO_REMOTE': '1', 04:24:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:04 INFO - 'NO_EM_RESTART': '1', 04:24:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:04 INFO - 'PWD': '/builds/slave/test', 04:24:04 INFO - 'SHELL': '/bin/bash', 04:24:04 INFO - 'SHLVL': '1', 04:24:04 INFO - 'TERM': 'linux', 04:24:04 INFO - 'TMOUT': '86400', 04:24:04 INFO - 'USER': 'cltbld', 04:24:04 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', 04:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:04 INFO - '_': '/tools/buildbot/bin/python'} 04:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:05 INFO - Running setup.py (path:/tmp/pip-UaeRvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:05 INFO - Running setup.py (path:/tmp/pip-otitXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:05 INFO - Running setup.py (path:/tmp/pip-UkucMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:05 INFO - Running setup.py (path:/tmp/pip-gUBm6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:05 INFO - Running setup.py (path:/tmp/pip-nrMheB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:05 INFO - Running setup.py (path:/tmp/pip-KDkO_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:05 INFO - Running setup.py (path:/tmp/pip-C58n_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:05 INFO - Running setup.py (path:/tmp/pip-UX9mHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:05 INFO - Running setup.py (path:/tmp/pip-ESVEKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:05 INFO - Running setup.py (path:/tmp/pip-QJ8VjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:05 INFO - Running setup.py (path:/tmp/pip-drYrEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:05 INFO - Running setup.py (path:/tmp/pip-5JfrXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:05 INFO - Running setup.py (path:/tmp/pip-7r_WlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:06 INFO - Running setup.py (path:/tmp/pip-6IJR1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:06 INFO - Running setup.py (path:/tmp/pip-GHnbGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:06 INFO - Running setup.py (path:/tmp/pip-el7UZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:06 INFO - Running setup.py (path:/tmp/pip-W3VAr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:24:06 INFO - Running setup.py install for manifestparser 04:24:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:24:06 INFO - Running setup.py install for mozcrash 04:24:06 INFO - Running setup.py install for mozdebug 04:24:06 INFO - Running setup.py install for mozdevice 04:24:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:24:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:24:06 INFO - Running setup.py install for mozfile 04:24:06 INFO - Running setup.py install for mozhttpd 04:24:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:24:06 INFO - Running setup.py install for mozinfo 04:24:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Running setup.py install for mozInstall 04:24:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Running setup.py install for mozleak 04:24:07 INFO - Running setup.py install for mozlog 04:24:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Running setup.py install for moznetwork 04:24:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Running setup.py install for mozprocess 04:24:07 INFO - Running setup.py install for mozprofile 04:24:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Running setup.py install for mozrunner 04:24:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Running setup.py install for mozscreenshot 04:24:07 INFO - Running setup.py install for moztest 04:24:08 INFO - Running setup.py install for mozversion 04:24:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:24:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:24:08 INFO - Cleaning up... 04:24:08 INFO - Return code: 0 04:24:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24: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:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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 0x7f624943bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2120410>, '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 0x2121310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21217a0>, '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': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', '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:24: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:24: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:24:08 INFO - Using env: {'DISPLAY': ':0', 04:24:08 INFO - 'HOME': '/home/cltbld', 04:24:08 INFO - 'LANG': 'en_US.UTF-8', 04:24:08 INFO - 'LANGUAGE': 'en_US:en', 04:24:08 INFO - 'LOGNAME': 'cltbld', 04:24:08 INFO - 'MAIL': '/var/mail/cltbld', 04:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:08 INFO - 'MOZ_NO_REMOTE': '1', 04:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:08 INFO - 'NO_EM_RESTART': '1', 04:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:08 INFO - 'PWD': '/builds/slave/test', 04:24:08 INFO - 'SHELL': '/bin/bash', 04:24:08 INFO - 'SHLVL': '1', 04:24:08 INFO - 'TERM': 'linux', 04:24:08 INFO - 'TMOUT': '86400', 04:24:08 INFO - 'USER': 'cltbld', 04:24:08 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', 04:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:08 INFO - '_': '/tools/buildbot/bin/python'} 04:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:08 INFO - Running setup.py (path:/tmp/pip-LSMkO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24: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:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:08 INFO - Running setup.py (path:/tmp/pip-vSgAOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:08 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:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:08 INFO - Running setup.py (path:/tmp/pip-U8Pk9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:08 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:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:08 INFO - Running setup.py (path:/tmp/pip-Gye6ES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:08 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:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:08 INFO - Running setup.py (path:/tmp/pip-n1oEii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:08 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:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:08 INFO - Running setup.py (path:/tmp/pip-HLYKkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:08 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:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:08 INFO - Running setup.py (path:/tmp/pip-ns83v9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:08 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:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:08 INFO - Running setup.py (path:/tmp/pip-gaNY4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:08 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:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:08 INFO - Running setup.py (path:/tmp/pip-UzOOM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24: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:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:09 INFO - Running setup.py (path:/tmp/pip-mXm0P2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24: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:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:09 INFO - Running setup.py (path:/tmp/pip-RpyVBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24: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:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:09 INFO - Running setup.py (path:/tmp/pip-5q2M40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24: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:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:09 INFO - Running setup.py (path:/tmp/pip-Q4jT6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24: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:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:09 INFO - Running setup.py (path:/tmp/pip-g7bG6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24: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:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:09 INFO - Running setup.py (path:/tmp/pip-tS_V3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24: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:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:09 INFO - Running setup.py (path:/tmp/pip-hbiOuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24: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:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:09 INFO - Running setup.py (path:/tmp/pip-JcJWwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24: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:24: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:24: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:24: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:24: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:24: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:24:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:24: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:24: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:24: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:24: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:24: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:24: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:24:11 INFO - Downloading blessings-1.6.tar.gz 04:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:24:11 INFO - Installing collected packages: blessings 04:24:11 INFO - Running setup.py install for blessings 04:24:11 INFO - Successfully installed blessings 04:24:11 INFO - Cleaning up... 04:24:11 INFO - Return code: 0 04:24:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:24:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:11 INFO - Reading from file tmpfile_stdout 04:24:11 INFO - Current package versions: 04:24:11 INFO - argparse == 1.2.1 04:24:11 INFO - blessings == 1.6 04:24:11 INFO - blobuploader == 1.2.4 04:24:11 INFO - docopt == 0.6.1 04:24:11 INFO - manifestparser == 1.1 04:24:11 INFO - mozInstall == 1.12 04:24:11 INFO - mozcrash == 0.17 04:24:11 INFO - mozdebug == 0.1 04:24:11 INFO - mozdevice == 0.48 04:24:11 INFO - mozfile == 1.2 04:24:11 INFO - mozhttpd == 0.7 04:24:11 INFO - mozinfo == 0.9 04:24:11 INFO - mozleak == 0.1 04:24:11 INFO - mozlog == 3.1 04:24:11 INFO - moznetwork == 0.27 04:24:11 INFO - mozprocess == 0.22 04:24:11 INFO - mozprofile == 0.28 04:24:11 INFO - mozrunner == 6.11 04:24:11 INFO - mozscreenshot == 0.1 04:24:11 INFO - mozsystemmonitor == 0.0 04:24:11 INFO - moztest == 0.7 04:24:11 INFO - mozversion == 1.4 04:24:11 INFO - psutil == 3.1.1 04:24:11 INFO - requests == 1.2.3 04:24:11 INFO - wsgiref == 0.1.2 04:24:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:11 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:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:11 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:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:11 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 0x7f624943bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2120410>, '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 0x2121310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21217a0>, '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': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', '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:24:11 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:24:11 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:24:11 INFO - Using env: {'DISPLAY': ':0', 04:24:11 INFO - 'HOME': '/home/cltbld', 04:24:11 INFO - 'LANG': 'en_US.UTF-8', 04:24:11 INFO - 'LANGUAGE': 'en_US:en', 04:24:11 INFO - 'LOGNAME': 'cltbld', 04:24:11 INFO - 'MAIL': '/var/mail/cltbld', 04:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:11 INFO - 'MOZ_NO_REMOTE': '1', 04:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:11 INFO - 'NO_EM_RESTART': '1', 04:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:11 INFO - 'PWD': '/builds/slave/test', 04:24:11 INFO - 'SHELL': '/bin/bash', 04:24:11 INFO - 'SHLVL': '1', 04:24:11 INFO - 'TERM': 'linux', 04:24:11 INFO - 'TMOUT': '86400', 04:24:11 INFO - 'USER': 'cltbld', 04:24:11 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', 04:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:11 INFO - '_': '/tools/buildbot/bin/python'} 04:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24: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:24: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:24: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:24: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:24: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:24: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:24: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:24: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:24: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:24: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:24: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:24:12 INFO - Cleaning up... 04:24:12 INFO - Return code: 0 04:24:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:24: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:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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 0x7f624943bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2120410>, '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 0x2121310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21217a0>, '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': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', '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:24: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:24: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:24:12 INFO - Using env: {'DISPLAY': ':0', 04:24:12 INFO - 'HOME': '/home/cltbld', 04:24:12 INFO - 'LANG': 'en_US.UTF-8', 04:24:12 INFO - 'LANGUAGE': 'en_US:en', 04:24:12 INFO - 'LOGNAME': 'cltbld', 04:24:12 INFO - 'MAIL': '/var/mail/cltbld', 04:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:12 INFO - 'MOZ_NO_REMOTE': '1', 04:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:12 INFO - 'NO_EM_RESTART': '1', 04:24:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:12 INFO - 'PWD': '/builds/slave/test', 04:24:12 INFO - 'SHELL': '/bin/bash', 04:24:12 INFO - 'SHLVL': '1', 04:24:12 INFO - 'TERM': 'linux', 04:24:12 INFO - 'TMOUT': '86400', 04:24:12 INFO - 'USER': 'cltbld', 04:24:12 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', 04:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:12 INFO - '_': '/tools/buildbot/bin/python'} 04:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:12 INFO - Downloading/unpacking jsonschema 04:24: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:24: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:24: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:24: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:24: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:24: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:24:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:24:14 INFO - Downloading/unpacking functools32 (from jsonschema) 04:24: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:24: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:24: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:24: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:24: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:24: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:24:14 INFO - Downloading functools32-3.2.3-2.tar.gz 04:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:24:14 INFO - warning: no files found matching '*.txt' 04:24:14 INFO - no previously-included directories found matching 'build' 04:24:14 INFO - no previously-included directories found matching 'dist' 04:24:14 INFO - no previously-included directories found matching '.git*' 04:24:14 INFO - Installing collected packages: jsonschema, functools32 04:24:14 INFO - Running setup.py install for functools32 04:24:14 INFO - warning: no files found matching '*.txt' 04:24:14 INFO - no previously-included directories found matching 'build' 04:24:14 INFO - no previously-included directories found matching 'dist' 04:24:14 INFO - no previously-included directories found matching '.git*' 04:24:14 INFO - Successfully installed jsonschema functools32 04:24:14 INFO - Cleaning up... 04:24:14 INFO - Return code: 0 04:24:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:24: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:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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 0x7f624943bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2120410>, '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 0x2121310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21217a0>, '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': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', '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:24: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:24: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:24:14 INFO - Using env: {'DISPLAY': ':0', 04:24:14 INFO - 'HOME': '/home/cltbld', 04:24:14 INFO - 'LANG': 'en_US.UTF-8', 04:24:14 INFO - 'LANGUAGE': 'en_US:en', 04:24:14 INFO - 'LOGNAME': 'cltbld', 04:24:14 INFO - 'MAIL': '/var/mail/cltbld', 04:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:14 INFO - 'MOZ_NO_REMOTE': '1', 04:24:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:14 INFO - 'NO_EM_RESTART': '1', 04:24:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:14 INFO - 'PWD': '/builds/slave/test', 04:24:14 INFO - 'SHELL': '/bin/bash', 04:24:14 INFO - 'SHLVL': '1', 04:24:14 INFO - 'TERM': 'linux', 04:24:14 INFO - 'TMOUT': '86400', 04:24:14 INFO - 'USER': 'cltbld', 04:24:14 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', 04:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:14 INFO - '_': '/tools/buildbot/bin/python'} 04:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:14 INFO - Downloading/unpacking flake8 04:24: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:24: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:24: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:24: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:24: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:24: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:24:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:24:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:24: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:24: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:24: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:24: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:24: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:24: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:24:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:24:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:24: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:24: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:24: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:24: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:24: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:24: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:24:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:24: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:24: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:24: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:24: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:24: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:24: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:24:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:24:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:24:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:24:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:24:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:24:17 INFO - no previously-included directories found matching 'docs/_build' 04:24:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:24:17 INFO - Running setup.py install for pep8 04:24:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:24:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:24:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:24:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:24:17 INFO - no previously-included directories found matching 'docs/_build' 04:24:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:24:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:24:17 INFO - Cleaning up... 04:24:17 INFO - Return code: 0 04:24:17 INFO - Running post-action listener: _resource_record_post_action 04:24:17 INFO - Running post-action listener: _start_resource_monitoring 04:24:17 INFO - Starting resource monitoring. 04:24:17 INFO - ##### 04:24:17 INFO - ##### Running install step. 04:24:17 INFO - ##### 04:24:17 INFO - Running pre-action listener: _resource_record_pre_action 04:24:17 INFO - Running main action method: install 04:24:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:17 INFO - Reading from file tmpfile_stdout 04:24:17 INFO - Detecting whether we're running mozinstall >=1.0... 04:24:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:24:18 INFO - Reading from file tmpfile_stdout 04:24:18 INFO - Output received: 04:24:18 INFO - Usage: mozinstall [options] installer 04:24:18 INFO - Options: 04:24:18 INFO - -h, --help show this help message and exit 04:24:18 INFO - -d DEST, --destination=DEST 04:24:18 INFO - Directory to install application into. [default: 04:24:18 INFO - "/builds/slave/test"] 04:24:18 INFO - --app=APP Application being installed. [default: firefox] 04:24:18 INFO - mkdir: /builds/slave/test/build/application 04:24:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:24:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:24:33 INFO - Reading from file tmpfile_stdout 04:24:33 INFO - Output received: 04:24:33 INFO - /builds/slave/test/build/application/firefox/firefox 04:24:33 INFO - Running post-action listener: _resource_record_post_action 04:24:33 INFO - ##### 04:24:33 INFO - ##### Running run-tests step. 04:24:33 INFO - ##### 04:24:33 INFO - Running pre-action listener: _resource_record_pre_action 04:24:33 INFO - Running main action method: run_tests 04:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:24:33 INFO - Python 2.7.3 04:24:33 INFO - Return code: 0 04:24:33 INFO - grabbing minidump binary from tooltool 04:24: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:24: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 0x2120410>, '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 0x2121310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21217a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:24: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:24: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:24:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:24:33 INFO - Return code: 0 04:24:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:24:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:24:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:24:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:24:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:24:34 INFO - Return code: 0 04:24:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:24:34 INFO - Using env: {'DISPLAY': ':0', 04:24:34 INFO - 'HOME': '/home/cltbld', 04:24:34 INFO - 'LANG': 'en_US.UTF-8', 04:24:34 INFO - 'LANGUAGE': 'en_US:en', 04:24:34 INFO - 'LOGNAME': 'cltbld', 04:24:34 INFO - 'MAIL': '/var/mail/cltbld', 04:24:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:24:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:34 INFO - 'MOZ_NO_REMOTE': '1', 04:24:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:34 INFO - 'NO_EM_RESTART': '1', 04:24:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:34 INFO - 'PWD': '/builds/slave/test', 04:24:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:24:34 INFO - 'SHELL': '/bin/bash', 04:24:34 INFO - 'SHLVL': '1', 04:24:34 INFO - 'TERM': 'linux', 04:24:34 INFO - 'TMOUT': '86400', 04:24:34 INFO - 'USER': 'cltbld', 04:24:34 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660', 04:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:34 INFO - '_': '/tools/buildbot/bin/python'} 04:24:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:24:35 INFO - mozversion application_buildid: 20160425025650 04:24:35 INFO - mozversion application_changeset: 1c6385ae1fe7e37d8f23f958ce14582f07af729e 04:24:35 INFO - mozversion application_display_name: Nightly 04:24:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:24:35 INFO - mozversion application_name: Firefox 04:24:35 INFO - mozversion application_remotingname: firefox 04:24:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:24:35 INFO - mozversion application_vendor: Mozilla 04:24:35 INFO - mozversion application_version: 48.0a1 04:24:35 INFO - mozversion platform_buildid: 20160425025650 04:24:35 INFO - mozversion platform_changeset: 1c6385ae1fe7e37d8f23f958ce14582f07af729e 04:24:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:24:35 INFO - mozversion platform_version: 48.0a1 04:24:35 INFO - using testdate: 1461583475 04:24:35 INFO - actual date: 1461583475 04:24:35 INFO - starting webserver on 'localhost:42902' 04:24:35 INFO - SUITE-START | Running 2 tests 04:24:35 INFO - TEST-START | dromaeo_css 04:24:35 INFO - operating with platform_type : linux_ 04:24:35 INFO - Initialising browser for dromaeo_css test... 04:24:35 INFO - TEST-INFO | started process 12527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp832EPr/profile http://localhost:42902/getInfo.html) 04:24:39 INFO - PROCESS | 12527 | __metrics Screen width/height:1600/1200 04:24:39 INFO - PROCESS | 12527 | colorDepth:24 04:24:39 INFO - PROCESS | 12527 | Browser inner width/height: 1024/697 04:24:39 INFO - PROCESS | 12527 | __metrics 04:24:40 ERROR - PROCESS | 12527 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:24:41 INFO - TEST-INFO | 12527: exit 0 04:24:41 INFO - Browser initialized. 04:24:41 INFO - Running cycle 1/1 for dromaeo_css test... 04:24:41 INFO - TEST-INFO | started process 12607 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp832EPr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:53 INFO - PROCESS | 12607 | RSS: Main: 156508160 04:24:53 INFO - PROCESS | 12607 | 04:25:44 INFO - PROCESS | 12607 | 1461583544289 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:27:55 INFO - PROCESS | 12607 | Cycle 1(1): loaded http://localhost:42902/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42902/tests/dromaeo/cssquery-ext.html) 04:27:56 INFO - PROCESS | 12607 | RSS: Main: 264622080 04:27:56 INFO - PROCESS | 12607 | 04:30:59 INFO - PROCESS | 12607 | Cycle 1(1): loaded http://localhost:42902/tests/dromaeo/cssquery-ext.html (next: http://localhost:42902/tests/dromaeo/cssquery-jquery.html) 04:30:59 INFO - PROCESS | 12607 | RSS: Main: 239849472 04:30:59 INFO - PROCESS | 12607 | 04:34:02 INFO - PROCESS | 12607 | Cycle 1(1): loaded http://localhost:42902/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42902/tests/dromaeo/cssquery-mootools.html) 04:34:02 INFO - PROCESS | 12607 | RSS: Main: 233250816 04:34:02 INFO - PROCESS | 12607 | 04:37:04 INFO - PROCESS | 12607 | Cycle 1(1): loaded http://localhost:42902/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42902/tests/dromaeo/cssquery-prototype.html) 04:37:05 INFO - PROCESS | 12607 | RSS: Main: 230125568 04:37:05 INFO - PROCESS | 12607 | 04:40:08 INFO - PROCESS | 12607 | Cycle 1(1): loaded http://localhost:42902/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42902/tests/dromaeo/cssquery-yui.html) 04:40:09 INFO - PROCESS | 12607 | RSS: Main: 212086784 04:40:09 INFO - PROCESS | 12607 | 04:43:11 INFO - PROCESS | 12607 | Cycle 1(1): loaded http://localhost:42902/tests/dromaeo/cssquery-yui.html (next: http://localhost:42902/tests/dromaeo/cssquery-dojo.html) 04:43:11 INFO - PROCESS | 12607 | RSS: Main: 268935168 04:43:11 INFO - PROCESS | 12607 | 04:43:11 INFO - PROCESS | 12607 | __start_tp_report 04:43:11 INFO - PROCESS | 12607 | _x_x_mozilla_page_load 04:43:11 INFO - PROCESS | 12607 | _x_x_mozilla_page_load_details 04:43:11 INFO - PROCESS | 12607 | |i|pagename|runs| 04:43:11 INFO - PROCESS | 12607 | |0;dojo.html;2609.5041942031016;2679.2498100531857;2685.3957859481607;2692.2192564156408;2722.782177425806;4518.480374756904;4645.674802763808;4663.65022623303;4675.275332323491;4696.788644511001;4595.747233902134;4653.767311634413;4654.790534425951;4684.250519916814;4697.85906422807;4242.236397448458;4272.081502476967;4274.337477690948;4318.632916202127;4353.978230108845;4232.53442121368;4361.629261512775;4393.319035549479;4416.984093658461;4432.734035957837;4343.9348409773875;4349.3475978603465;4369.1916995355805;4385.2106620808245;4435.866923992286;4194.643455306303;4278.272693642089;4281.7002809803325;4282.743035417885;4365.170617582649;4231.682623803227;4282.700210985232;4308.80610372534;4312.82748690052;4343.565643435662;4569;4596.4254468191475;4610.377599024156;4611.700239484423;4637.188492013884;4880.048390563841;4894.36373271476;4931.630127740434;4977.402711674622;4982.451930287665;4955.529224723646;4956.553910148104;4970.105381031449;4970.850874473772;4996.775145118479;4464.531224221475;4627.514111018295;4629.305604159369;4629.768511574408;4648.604868586141;5090;5177.326947496801;5194.97402512985;5200.557952574073;5212.765425555859;4887.364642596511;4911.729854857946;4915.680480768739;4922.335484709519;4961.776720047535;4971.080350135237;4982.8754281143265;4985.177445721415;4985.975070124626;5037.269595908646;4778.976105119452;4896.314515967767;4944.950550494521;4970.304157417892;4993.525615066563;4938.061768264019;4951.3810773653295;4965.131102057126;4968.403791545038;5020.548150666385;4122.91754164915;4228.640565551901;4238.830446782094;4246.554111818215;4294.6993710439965;3673.540807399075;3687.8524859005875;3715.2569486102348;3754.6996240301255;3777.131259810204;4281.571842815693;4305.203537345601;4308.482982042112;4337.327714204303;4360.127974405068;4919.704817710949;4938.407391113017;4962.106820772224;4966.776495057731;5017.724025178651;4302.3546468030045;4334.653227741773;4337.9132417351475;4349.717268377545;4372.366006928977;4481.619062379734;4508.1659892919915;4519.480259770168;4530.4110465639915;4553.886152846206;4567.771611419482;4720.457147427953;4742.241241401497;4745.525447455227;4750.809967601326;4929.704217746947;4936.75316234194;4948.851534453972;4974.651774375904;4998.6750861193905;4658.883527911829;4660.324252983366;4661.230896901973;4672.439307283012;4718.433787945469;4726.740029298284;4791.832285869978;4866.416030076413;4900.583450406755;4933.235348520985;4906.975465122794;4916.139675556692;4922.630802689741;4951.9257211142585;4964.230544265644;4825.782839772149;4826.7827947743135;4831.661783675109;4880.048390563806;4880.389951256093;4767.165745994506;4780.163471392562;4839.201531747222;4878.463369029333;4886.047220791911;4741.193997020446;4761.119192949315;4776.689515181641;4793.640476964172;4817.181079216612;4855.053264613366;4855.587275081658;4870.829520966749;4878.219484882402;4907.5828554571835;4674.22875225584;4706.811727530998;4800.039992001543;4801.1117943180625;4812.470628230962 04:43:11 INFO - PROCESS | 12607 | |1;ext.html;576.6050255574929;609.5854818723269;609.9725512351944;627.6046090962693;628.2555172121034;26550.6017409739;34957;35877;35897;35902.46146307808;38215;38849.22301553974;38884;38936.22127557454;39023.80488097563;7647.502912310696;7847.843043139133;7848.45060845741;7850.450468467209;7854.136045035041;7634.50375725576;7743.18696536864;7761.883571746428;7766.068071831388;7770.33952114071;7952.324052455549;7990.360771138324;8021.799455013642;8025.036995560512;8026.478278911881;7857.764267071969;7917.445778795458;7954;7964.283214510664;7966.5618390988475;7833.804154896116;7945.602719863984;7946.324562412202;7948.364130869517;7948.721794737215;37916.24167516634;38411.03972400684;38467.23065538674;38554.228915421816;38657.61342386568;2931.6042334285025;2948.8378139202337;3005.5040918248465;3104.161876293388;3580.534530511017;26625.600615990777;27068.59397109045;28961;29188.854055729797;30003;3304.7851889627095;3411.1301618087227;3425.5718035245595;3476.356873978297;3564.3940530109944;162769;165700;166358;167070;167849.16075419544;47881;48085;48280;48375.75812120917;48398.516014840105;50254.74872625613;50418;50738.23892641613;51706.22440663393;51877.74061129746;14625.78061329081;14809.407623695148;14869.553913382615;14876.92561537207;14889.255537223313;11224.382658953837;11271.492782824793;11272.380019098864;11284.830727539094;11294.774104517863;17513.824861751218;17636.47090587259;17654.823451765576;17679.823201768075;17732.20205090774;6689.632070236184;7032.12098487689;7083.433325333961;7130.928690713026;7161;824.118193532926;830.2022185235794;889.7908991387019;909.4316052467208;918.7932715139174;28247.717522824507;28641.57037644437;28756.386725532102;28827.711722882923;29104;873.991260087391;933.2580598424133;945.9054094590485;954.1365064616533;993.5330394714473;15114.773278400833;15157.924210378878;15309.923450382677;15549.144797036271;15645.061296322257;312253;319126;319926;320347;320945;48365.032699345815;48632.5136748628;48838.5116148834;49013;49097.10834699859;1170.3212136960542;1181.7695549367963;1191.6722901202413;1208.5528354508888;1304.8434187897324;24921.875390622932;26012.73987260179;26574.335641609116;26637.866810665822;26688.466230675665;35895.46156807702;36123.819380902925;36135;36181.457278140326;36189;182158;182477;183297;183410;183508;20777;20971;21484.14063437445;23871.403214919766;23996.76003240015;35656.82171589125;37215.441768372955;37241.81379093087;37926.810365948;38410.0397490065;31506.842465787526;32878.671213288515;33169.170770730925;33509.83245083759;33622.159446013065;32481;32847.178820529676;32999.17502062372;33144.668553315125;33161;32746.672533274363;33010.367164164294;33283.167920802174;34998.65001349954;35194.29611407809;30489.23776905595;31772.205694857814;32185.678143219204;32227.838860805547;32449.675503244664;24134.155304564258;24576.87711561431;24805.00779968781;24999.500289832216;25093.87453062723 04:43:11 INFO - PROCESS | 12607 | |2;jquery.html;379.0542596222424;380.20157668895325;381.3307645082879;381.40881633468115;382.50274642964155;15836.445724399648;16189;17104.31582736689;17106.486805395827;17135.228914698837;11891.989180919632;15503.147326897017;16263.268152933117;16269.51191464255;16284.348626054973;4630.953690463103;4749.430068391798;4790.257510085942;4797.112534181188;4804.543568361;3478.200013996782;4641.443026836784;5109.208072748711;5387.946120538803;5407.702576358299;5371.81198658047;5390.703511306877;5395.81114660987;5409.7295135243085;5411.107167317388;5029.1450453423;5316.9734151329385;5323.973380133075;5327.174287985368;5434.7826086956475;3369.8146601936883;4927.6304277179;5177.45636708144;5191.662541934762;5193.428722840485;11693.649190524298;11820.940895295555;11880.821787673192;12665;19782;1677.429673910864;1720.8623310135158;1867.0104844432472;1871.4479228627588;1926.0851095729556;8663.176998185163;8985.955070224672;9012.77468063297;9018.278537717033;9110;1646.4319809665647;1662.709025920459;1668.9165541722987;1720.5440558252074;1732.488915769851;63039.36960630381;64003;66711.33288667149;67819.3218067818;70026.64986675086;10050.296479246528;10081.294309398418;10099.596016159272;10174.949125254327;10271.126954208827;14246.287685615678;14266.3580138894;14342.713145737027;14346.856531434552;14363.712725745427;6911.274316196827;7100.396466300319;7136.143662760502;7177.605231712306;7212;6667;6680.498962577826;6720.798376048726;6732.663366831737;6899.862002759916;4337.175936572041;4384.167008268419;4410.845620403271;4411.492678341968;4459.0858873930765;1682.6634673065437;1809.6561653285833;1825.3611236067536;1879.2483006797117;1929.2572359641358;822.7490615362371;832.3466079127855;836.510641274861;883.6597909804772;891.7948871759531;15842.60393490172;16147.596310092342;16921.661566768595;17050.23273952675;17277.913610431868;824.4517395931758;836.8953880764905;902.5306840442933;903.7379160043514;933.5472295936465;9128.634854605874;9139.908600913906;9381;9832.508374581384;9846.507674616383;359737;362090;362675;362835;363063;73553.26446735571;76119.23880761232;77473.61263193648;77868;78378.6081069591;947.9952600237093;954.2938225712923;972.9513524323755;977.5454413697664;986.8371718666483;15244.695106097593;15270.312835922188;15372.154531500428;15464.5360639181;15678.686426271639;32675.509867352484;33254.836080737055;34373.48439773455;34426.311473769885;34796;46343.53656463527;46524.53475465202;47476.28785568288;48290;48359.758201208766;7299.781006569599;7356;7370.22612625688;7423.777286681408;7482.289182527651;7791.065072191147;11140.275882067639;11447;11486;11910;9915.30592858493;10161.136303414292;10266.58933642646;10357.896421035995;10401.94799026;5028.547430731252;8270.214329638675;9573.468245081032;10207.489625518843;10567.788644227227;10086.092251697382;10132.64535741275;10704.571817127227;11054.170937179582;11172.385518796544;7598.506097103671;7860.528368297921;7890.842183156419;7919.326857217201;8059.355251579742;7906.16985216544;9549.283803714889;10302.278840481094;10668.946655266674;10756.946215268874 04:43:11 INFO - PROCESS | 12607 | |3;mootools.html;1208.8972437342825;1386.0782579584577;1446.732354514415;1489.158625376662;1675.170790458723;6419.454346380558;7387.18740938497;7670.846583068335;7680.347170490515;7685.154632990374;7441.107067151936;7570.394368450511;7579.886301705479;7586.127595326539;7592.050993625797;1859.860510461714;1914.7606549181353;1916.7412399326122;2169.6420090685056;2211.5466329402434;2184.388371256051;2254.966175507369;2266.889224280099;2270.8523945943543;2279.122537822942;2121.4378189779723;2149.9032543535577;2161.016737384486;2162.5350549631826;2216.567769284982;1893.195391958426;2110.472381904524;2139.208492857637;2146.9463263418384;2150.161437039548;2144.9892750536305;2169.1323470611724;2172.5546263016045;2173.1850556041486;2175.0973346061523;7377.114746230433;7418.146913105008;7426.257374262585;7438.293362130589;7454.329110380092;4452.510223875371;4595.586397224266;4596.54034596541;4603.309503574457;4603.424571928509;2806.0599699100826;2900.5794159846914;2908.9854550727323;2915.3440475892967;2916.970830291691;854.4104567848165;872.0930232558131;879.6393478673778;887.671561522241;921.6037104045258;10226.744331391701;10234.744131396774;10243.385396876136;10254.436006019667;10263.486825658762;4194.937075943863;4301.913961720748;4345.8261669533495;4380.277254253013;4391.494978077498;8762.38663293576;8848.336374771918;8860.335474839283;8867.423617464845;8874.334424918157;4690.530946905282;4703.576678098988;4705.482396936334;4712.858614241578;4721.504242054603;3592.4431713084514;3965.841366345314;4158.4178215049915;4175.123224122968;4209;3604.2611264690677;3698.4082546792383;3717.9628203717616;3744.213715119801;3832.4442955771256;1181.0846593889805;1209.915305928594;1223.5411720604773;1233.9506419743288;1236.7279198576298;811.6972259523498;819.3690858039276;829.5989774247554;854.5043874552745;859.1408591408591;4891.877703057381;5008.223725322581;5053.292539044537;5086.796528138907;5123.180291153398;401.6886912642725;407.5415157947309;411.96498297645036;413.6153377359025;414.66619371405704;3381.5434916286476;3414.214730611973;3414.778039427429;3448.74134439913;3492.336456073338;8997.505137217386;9116.81766364669;9305.25557955362;9469.053094690476;9470.763230919281;9302.069793020779;9349.766255843522;9376.296777741696;9394.483303418241;9427.387219830689;6990.056342393814;7147.2138064812825;7227.747028853965;7295.124585049722;7298.489105762652;4954.157793175241;4974.129527332775;5005.224190250517;5145.742712864417;5171.120909445479;8460.407771455939;8653.69712060075;8655.52394618302;8683.478991260545;8716.912830871865;8419.83160336802;8559.272461840565;8636.352273579381;8738.43200192011;8817.515036673045;5966.224390829165;6311.873762524816;6487.54587178893;6558.737650494118;6741.157355330583;7276.272372762682;7284.417246620364;7327.816804579928;7331.74338898136;7356.043714317105;5949.940500594938;6415.294317624965;6465.353464653497;6478.028295755675;6584.374484423972;6321.810345689637;6385.808425747235;6436.388543088399;6456.031595260749;6489.805305840832;5686.943130568641;5809.796657116981;5821.76712931478;5822.097574875901;5837.532997360286;4341.739495630146;4364.585364390377;4390.736555806662;4405.38324634545;4430.560067977855;4308.332208507686;4384.364267181305;4419.977900110479;4450.755208463565;4482.282834746425 04:43:11 INFO - PROCESS | 12607 | |4;prototype.html;281.8703396437639;300.0458541836958;301.1312363830349;306.94628440023007;307.75533450906534;4672.883177920554;4685;4704.835330763424;4749.596284315833;4765.904681906364;4384.693071484998;4505.526919673436;4549.522300158485;4639.7912093955765;4675.509071547481;3709.9443508347395;3735.8879233622897;3755.5868854426126;3758.981205093971;3767.1523907120886;3730.601024615769;3762.6613604775566;3764.9435258471144;3770.095177157476;3775.9056023599355;3533.275678485917;3604.945925811115;3728.403455447129;3740.8316625751772;3755.9624403756025;3710.4619830124752;3713.9071523211865;3722.311372396102;3727.8816355093636;3747.938633751453;3320.2197483591335;3325.983370083134;3327.916802079943;3332.583427071616;3342.4484959981573;4401.845935392246;4484.641228701728;4526.977365113154;4539.773011349453;4539.909201815945;4208.3687446882905;4219.9578004219875;4239.300515414983;4256.34026725858;4264.509581398148;4834.3473631059705;4851.466338702739;4856.660033797635;4883.658143929926;4890.413150421937;3584.6415358464205;3596.7122630189524;3599.5680518337967;3608.711303095746;3616.566012078541;4875.780589873464;5067.986402719471;5087.745612719386;5119.616028797818;5129.153689641204;3674.4488326751202;3697.852085916587;3699.9075023124637;3701.40777475608;3703.2223233121344;3729.9813500932864;3746.662800347982;3764.5294338207723;3764.661180493769;3791.563970143414;3899.757639357381;4163.521195062546;4211.873643790691;4222.704410691222;4225.302825033897;4846.224604063404;4897.191963326082;4901.901961960741;4915.778789954461;4926.507349265116;1246.9438875250635;1275.4196840437578;1304.7651422743998;1308.4373719300793;1314.789633658629;879.5426378283385;885.526243459746;902.366716243588;909.1590278991906;912.4160537256162;4618.35343051973;4620.897491641295;4638.466576343696;4644.303354496852;4649.651276154302;5322.3879253885525;5323.866903327448;5342.492463215988;5358.16948372995;5361.892762144813;4510.684252102387;4572.382728331632;4628.143793398165;4628.634552806862;4638;2836.6737825149958;2842.2041828287697;2852.6434195725533;2855.2433605094666;2861.699521550249;5041.621878359065;5085.618578606619;5109.412417572027;5117.744112794346;5118.488151184852;5295.761690723926;5482.588805839578;5484.862878428071;5487.670739755627;5509.972450137724;5037.143685573388;5041.445441001413;5057.519535644108;5083.339165908408;5106.106431374569;5338.225957236256;5361.544268737201;5363.678179309254;5371.785128594969;5378.327709036371;4711.8822029448165;4933.9506604933495;5011.1709226132925;5213.191955246943;5226.2230841514065;4787.736674482937;4858.902821943612;4869.415670119608;4869.926951095807;4886.753877761148;3665.871694490787;3724.6534683149443;3733.8693145739767;3753.812309384465;3754.305453491113;4822.156122678447;4990.426100998432;5031.9181376004335;5089.92365114531;5119.078565858182;4770.618350532019;4858.392700912386;4935.259711043373;4951.331570238116;4996.800127994839;4912.729799861042;4915.361003069578;4941.357623508921;4986.177280748636;4990.128701736849;4638.443386793607;4845.9757701211265;4883.633727470383;4893.21708526634;4898.167311556973;4981.626378021735;4989;4991.950080499294;5002.52476014778;5022.899542009212;4846.660733748604;4852.781624826821;4902.411710594752;4910.361652985232;4912.189488734319 04:43:11 INFO - PROCESS | 12607 | |5;yui.html;636.5703150373498;752.8983587215724;755.9886601700972;768.5158350239349;780.8126049748062;11671;11798.1151413644;11887.22733022353;12093.879061209385;12107.757844843098;11607.535698572046;12198.939005304961;12217.450214740336;12244.081693872973;12246.632601021962;638.4190386748037;786.7246463737703;796.0208943000099;805.9838803223932;822.383212590557;816.7672213419177;819.4755356571799;819.774561995453;821.0434843407423;821.4003777242616;844.8014716541608;845.5434065604566;846.0777752250046;848.8854004709347;849.0109022988212;664.1598378051768;827.5076329583887;845.5729856422498;855.0807881527383;856.3277826905849;616.4575173846986;620.2030390947656;624.1729708136692;625.383996763188;625.4621025917708;12233.143679942408;12270.509179632803;12293.139480236387;12334.198277111958;12362.567310144103;11590.710232244177;11918.642440726706;11950.701232469171;12133.21134126279;12261.632151035394;9675.70972870815;9793.167580755644;9943.850842237372;9984.301098923079;10021.59913603455;3293.967060329414;3347.7656564040526;3368.562086928708;3448.74134439918;3468.3930312195266;42030;42143.789281053396;42151.7892410536;42208;44335.113297734184;9907.851382229272;9932.503374831374;9986.650467233758;10067.345622534513;10125.949370253102;17978.460646180636;18062.909685451752;18079.63840723178;18097.638047239245;18133.546661333574;6569.80290591283;6652;6683.298253683391;6697.832554186184;6858.211305699809;3536.504889315498;3554.87557935471;3623.909402264912;3676.816159192083;3712.0348709335767;2765.198092553137;2830.3348713052414;2832.107886015898;2832.603435519029;2836.971630283671;405.36155555000994;463.8793913582493;487.12317827909624;487.7853744352474;544.5317027356471;531.9069162896556;567.7473524281655;568.2158621102851;590.3771521045338;601.5338112962489;6851.897221541681;7075.186353569303;7094.326039026284;7255.238199988925;7264.491485595958;555.0785695745044;555.908513341804;556.7605929450294;573.4609467100995;587.0724255676022;3484.77348972316;3550.822458877046;3573.4639804029084;3658.3049220648522;3684.6499582539614;44142.77928610337;48690;48821.51178488241;48860.267095993586;52817.2077418839;42079.7896010518;42435.15129697389;44534.33198502025;45373.773131134134;45638;40491.39262911059;41119.1776164475;41197;41205.1758964819;42113.15773684509;7325.523840950321;7377.8155546111775;7394.741184058532;7520.548767073993;7528.661210245443;28344.43311133807;28363.57454638141;28804.567931481462;28899.422011560073;29567.965121220655;35455.64544354523;36893.44659830158;37340;37390.62609373871;37423;9917.553710082919;9935.552900119368;10142.188624909842;10352;10354.275200735876;10748.623798167027;10850.29473084247;10928.125749939827;11163.330200188015;11182.273152245078;9723.124918757347;10455.94772026135;10467.162626989975;10569.207309451976;10766.838497422701;10046.54790534413;10128.746781330527;10389.168866490814;10612.628558000433;10761.677149685522;10121.544530495998;10178.338408003456;10220.693379198636;10422.530986105796;10572.788544229226;8609.65561377538;8932.460792728576;8939.195472407515;9110.088991101102;9155.908440915506;8658.307335413278;8708.608112635073;8968.148025937526;9116.954415227881;9140.782333508512 04:43:11 INFO - PROCESS | 12607 | __end_tp_report 04:43:11 INFO - PROCESS | 12607 | __start_cc_report 04:43:11 INFO - PROCESS | 12607 | _x_x_mozilla_cycle_collect,980 04:43:11 INFO - PROCESS | 12607 | __end_cc_report 04:43:11 INFO - PROCESS | 12607 | __startTimestamp1461584591985__endTimestamp 04:43:11 INFO - PROCESS | 12607 | 04:43:11 INFO - PROCESS | 12607 | ------- Summary: start ------- 04:43:11 INFO - PROCESS | 12607 | Number of tests: 6 04:43:11 INFO - PROCESS | 12607 | 04:43:11 INFO - PROCESS | 12607 | [#0] dojo.html Cycles:165 Average:4604.77 Median:4718.43 stddev:461.38 (9.8%) stddev-sans-first:435.43 04:43:11 INFO - PROCESS | 12607 | Values: 2609.5 2679.2 2685.4 2692.2 2722.8 4518.5 4645.7 4663.7 4675.3 4696.8 4595.7 4653.8 4654.8 4684.3 4697.9 4242.2 4272.1 4274.3 4318.6 4354.0 4232.5 4361.6 4393.3 4417.0 4432.7 4343.9 4349.3 4369.2 4385.2 4435.9 4194.6 4278.3 4281.7 4282.7 4365.2 4231.7 4282.7 4308.8 4312.8 4343.6 4569.0 4596.4 4610.4 4611.7 4637.2 4880.0 4894.4 4931.6 4977.4 4982.5 4955.5 4956.6 4970.1 4970.9 4996.8 4464.5 4627.5 4629.3 4629.8 4648.6 5090.0 5177.3 5195.0 5200.6 5212.8 4887.4 4911.7 4915.7 4922.3 4961.8 4971.1 4982.9 4985.2 4986.0 5037.3 4779.0 4896.3 4945.0 4970.3 4993.5 4938.1 4951.4 4965.1 4968.4 5020.5 4122.9 4228.6 4238.8 4246.6 4294.7 3673.5 3687.9 3715.3 3754.7 3777.1 4281.6 4305.2 4308.5 4337.3 4360.1 4919.7 4938.4 4962.1 4966.8 5017.7 4302.4 4334.7 4337.9 4349.7 4372.4 4481.6 4508.2 4519.5 4530.4 4553.9 4567.8 4720.5 4742.2 4745.5 4750.8 4929.7 4936.8 4948.9 4974.7 4998.7 4658.9 4660.3 4661.2 4672.4 4718.4 4726.7 4791.8 4866.4 4900.6 4933.2 4907.0 4916.1 4922.6 4951.9 4964.2 4825.8 4826.8 4831.7 4880.0 4880.4 4767.2 4780.2 4839.2 4878.5 4886.0 4741.2 4761.1 4776.7 4793.6 4817.2 4855.1 4855.6 4870.8 4878.2 4907.6 4674.2 4706.8 4800.0 4801.1 4812.5 04:43:11 INFO - PROCESS | 12607 | 04:43:11 INFO - PROCESS | 12607 | [#1] ext.html Cycles:180 Average:38257.47 Median:3450.96 stddev:60943.17 (1766.0%) stddev-sans-first:61048.46 04:43:11 INFO - PROCESS | 12607 | Values: 576.6 609.6 610.0 627.6 628.3 26550.6 34957.0 35877.0 35897.0 35902.5 38215.0 38849.2 38884.0 38936.2 39023.8 7647.5 7847.8 7848.5 7850.5 7854.1 7634.5 7743.2 7761.9 7766.1 7770.3 7952.3 7990.4 8021.8 8025.0 8026.5 7857.8 7917.4 7954.0 7964.3 7966.6 7833.8 7945.6 7946.3 7948.4 7948.7 37916.2 38411.0 38467.2 38554.2 38657.6 2931.6 2948.8 3005.5 3104.2 3580.5 26625.6 27068.6 28961.0 29188.9 30003.0 3304.8 3411.1 3425.6 3476.4 3564.4 162769.0 165700.0 166358.0 167070.0 167849.2 47881.0 48085.0 48280.0 48375.8 48398.5 50254.7 50418.0 50738.2 51706.2 51877.7 14625.8 14809.4 14869.6 14876.9 14889.3 11224.4 11271.5 11272.4 11284.8 11294.8 17513.8 17636.5 17654.8 17679.8 17732.2 6689.6 7032.1 7083.4 7130.9 7161.0 824.1 830.2 889.8 909.4 918.8 28247.7 28641.6 28756.4 28827.7 29104.0 874.0 933.3 945.9 954.1 993.5 15114.8 15157.9 15309.9 15549.1 15645.1 312253.0 319126.0 319926.0 320347.0 320945.0 48365.0 48632.5 48838.5 49013.0 49097.1 1170.3 1181.8 1191.7 1208.6 1304.8 24921.9 26012.7 26574.3 26637.9 26688.5 35895.5 36123.8 36135.0 36181.5 36189.0 182158.0 182477.0 183297.0 183410.0 183508.0 20777.0 20971.0 21484.1 23871.4 23996.8 35656.8 37215.4 37241.8 37926.8 38410.0 31506.8 32878.7 33169.2 33509.8 33622.2 32481.0 32847.2 32999.2 33144.7 33161.0 32746.7 33010.4 33283.2 34998.7 35194.3 30489.2 31772.2 32185.7 32227.8 32449.7 24134.2 24576.9 24805.0 24999.5 25093.9 04:43:11 INFO - PROCESS | 12607 | 04:43:11 INFO - PROCESS | 12607 | [#2] jquery.html Cycles:180 Average:22885.73 Median:25487.25 stddev:59915.47 (235.1%) stddev-sans-first:60059.72 04:43:11 INFO - PROCESS | 12607 | Values: 379.1 380.2 381.3 381.4 382.5 15836.4 16189.0 17104.3 17106.5 17135.2 11892.0 15503.1 16263.3 16269.5 16284.3 4631.0 4749.4 4790.3 4797.1 4804.5 3478.2 4641.4 5109.2 5387.9 5407.7 5371.8 5390.7 5395.8 5409.7 5411.1 5029.1 5317.0 5324.0 5327.2 5434.8 3369.8 4927.6 5177.5 5191.7 5193.4 11693.6 11820.9 11880.8 12665.0 19782.0 1677.4 1720.9 1867.0 1871.4 1926.1 8663.2 8986.0 9012.8 9018.3 9110.0 1646.4 1662.7 1668.9 1720.5 1732.5 63039.4 64003.0 66711.3 67819.3 70026.6 10050.3 10081.3 10099.6 10174.9 10271.1 14246.3 14266.4 14342.7 14346.9 14363.7 6911.3 7100.4 7136.1 7177.6 7212.0 6667.0 6680.5 6720.8 6732.7 6899.9 4337.2 4384.2 4410.8 4411.5 4459.1 1682.7 1809.7 1825.4 1879.2 1929.3 822.7 832.3 836.5 883.7 891.8 15842.6 16147.6 16921.7 17050.2 17277.9 824.5 836.9 902.5 903.7 933.5 9128.6 9139.9 9381.0 9832.5 9846.5 359737.0 362090.0 362675.0 362835.0 363063.0 73553.3 76119.2 77473.6 77868.0 78378.6 948.0 954.3 973.0 977.5 986.8 15244.7 15270.3 15372.2 15464.5 15678.7 32675.5 33254.8 34373.5 34426.3 34796.0 46343.5 46524.5 47476.3 48290.0 48359.8 7299.8 7356.0 7370.2 7423.8 7482.3 7791.1 11140.3 11447.0 11486.0 11910.0 9915.3 10161.1 10266.6 10357.9 10401.9 5028.5 8270.2 9573.5 10207.5 10567.8 10086.1 10132.6 10704.6 11054.2 11172.4 7598.5 7860.5 7890.8 7919.3 8059.4 7906.2 9549.3 10302.3 10668.9 10756.9 04:43:11 INFO - PROCESS | 12607 | 04:43:11 INFO - PROCESS | 12607 | [#3] mootools.html Cycles:180 Average:4968.39 Median:4923.02 stddev:2774.79 (56.4%) stddev-sans-first:2768.19 04:43:11 INFO - PROCESS | 12607 | Values: 1208.9 1386.1 1446.7 1489.2 1675.2 6419.5 7387.2 7670.8 7680.3 7685.2 7441.1 7570.4 7579.9 7586.1 7592.1 1859.9 1914.8 1916.7 2169.6 2211.5 2184.4 2255.0 2266.9 2270.9 2279.1 2121.4 2149.9 2161.0 2162.5 2216.6 1893.2 2110.5 2139.2 2146.9 2150.2 2145.0 2169.1 2172.6 2173.2 2175.1 7377.1 7418.1 7426.3 7438.3 7454.3 4452.5 4595.6 4596.5 4603.3 4603.4 2806.1 2900.6 2909.0 2915.3 2917.0 854.4 872.1 879.6 887.7 921.6 10226.7 10234.7 10243.4 10254.4 10263.5 4194.9 4301.9 4345.8 4380.3 4391.5 8762.4 8848.3 8860.3 8867.4 8874.3 4690.5 4703.6 4705.5 4712.9 4721.5 3592.4 3965.8 4158.4 4175.1 4209.0 3604.3 3698.4 3718.0 3744.2 3832.4 1181.1 1209.9 1223.5 1234.0 1236.7 811.7 819.4 829.6 854.5 859.1 4891.9 5008.2 5053.3 5086.8 5123.2 401.7 407.5 412.0 413.6 414.7 3381.5 3414.2 3414.8 3448.7 3492.3 8997.5 9116.8 9305.3 9469.1 9470.8 9302.1 9349.8 9376.3 9394.5 9427.4 6990.1 7147.2 7227.7 7295.1 7298.5 4954.2 4974.1 5005.2 5145.7 5171.1 8460.4 8653.7 8655.5 8683.5 8716.9 8419.8 8559.3 8636.4 8738.4 8817.5 5966.2 6311.9 6487.5 6558.7 6741.2 7276.3 7284.4 7327.8 7331.7 7356.0 5949.9 6415.3 6465.4 6478.0 6584.4 6321.8 6385.8 6436.4 6456.0 6489.8 5686.9 5809.8 5821.8 5822.1 5837.5 4341.7 4364.6 4390.7 4405.4 4430.6 4308.3 4384.4 4420.0 4450.8 4482.3 04:43:11 INFO - PROCESS | 12607 | 04:43:11 INFO - PROCESS | 12607 | [#4] prototype.html Cycles:180 Average:4175.40 Median:4674.20 stddev:1202.70 (25.7%) stddev-sans-first:1170.03 04:43:11 INFO - PROCESS | 12607 | Values: 281.9 300.0 301.1 306.9 307.8 4672.9 4685.0 4704.8 4749.6 4765.9 4384.7 4505.5 4549.5 4639.8 4675.5 3709.9 3735.9 3755.6 3759.0 3767.2 3730.6 3762.7 3764.9 3770.1 3775.9 3533.3 3604.9 3728.4 3740.8 3756.0 3710.5 3713.9 3722.3 3727.9 3747.9 3320.2 3326.0 3327.9 3332.6 3342.4 4401.8 4484.6 4527.0 4539.8 4539.9 4208.4 4220.0 4239.3 4256.3 4264.5 4834.3 4851.5 4856.7 4883.7 4890.4 3584.6 3596.7 3599.6 3608.7 3616.6 4875.8 5068.0 5087.7 5119.6 5129.2 3674.4 3697.9 3699.9 3701.4 3703.2 3730.0 3746.7 3764.5 3764.7 3791.6 3899.8 4163.5 4211.9 4222.7 4225.3 4846.2 4897.2 4901.9 4915.8 4926.5 1246.9 1275.4 1304.8 1308.4 1314.8 879.5 885.5 902.4 909.2 912.4 4618.4 4620.9 4638.5 4644.3 4649.7 5322.4 5323.9 5342.5 5358.2 5361.9 4510.7 4572.4 4628.1 4628.6 4638.0 2836.7 2842.2 2852.6 2855.2 2861.7 5041.6 5085.6 5109.4 5117.7 5118.5 5295.8 5482.6 5484.9 5487.7 5510.0 5037.1 5041.4 5057.5 5083.3 5106.1 5338.2 5361.5 5363.7 5371.8 5378.3 4711.9 4934.0 5011.2 5213.2 5226.2 4787.7 4858.9 4869.4 4869.9 4886.8 3665.9 3724.7 3733.9 3753.8 3754.3 4822.2 4990.4 5031.9 5089.9 5119.1 4770.6 4858.4 4935.3 4951.3 4996.8 4912.7 4915.4 4941.4 4986.2 4990.1 4638.4 4846.0 4883.6 4893.2 4898.2 4981.6 4989.0 4992.0 5002.5 5022.9 4846.7 4852.8 4902.4 4910.4 4912.2 04:43:11 INFO - PROCESS | 12607 | 04:43:11 INFO - PROCESS | 12607 | [#5] yui.html Cycles:180 Average:12204.32 Median:42321.58 stddev:13650.84 (32.3%) stddev-sans-first:13661.49 04:43:11 INFO - PROCESS | 12607 | Values: 636.6 752.9 756.0 768.5 780.8 11671.0 11798.1 11887.2 12093.9 12107.8 11607.5 12198.9 12217.5 12244.1 12246.6 638.4 786.7 796.0 806.0 822.4 816.8 819.5 819.8 821.0 821.4 844.8 845.5 846.1 848.9 849.0 664.2 827.5 845.6 855.1 856.3 616.5 620.2 624.2 625.4 625.5 12233.1 12270.5 12293.1 12334.2 12362.6 11590.7 11918.6 11950.7 12133.2 12261.6 9675.7 9793.2 9943.9 9984.3 10021.6 3294.0 3347.8 3368.6 3448.7 3468.4 42030.0 42143.8 42151.8 42208.0 44335.1 9907.9 9932.5 9986.7 10067.3 10125.9 17978.5 18062.9 18079.6 18097.6 18133.5 6569.8 6652.0 6683.3 6697.8 6858.2 3536.5 3554.9 3623.9 3676.8 3712.0 2765.2 2830.3 2832.1 2832.6 2837.0 405.4 463.9 487.1 487.8 544.5 531.9 567.7 568.2 590.4 601.5 6851.9 7075.2 7094.3 7255.2 7264.5 555.1 555.9 556.8 573.5 587.1 3484.8 3550.8 3573.5 3658.3 3684.6 44142.8 48690.0 48821.5 48860.3 52817.2 42079.8 42435.2 44534.3 45373.8 45638.0 40491.4 41119.2 41197.0 41205.2 42113.2 7325.5 7377.8 7394.7 7520.5 7528.7 28344.4 28363.6 28804.6 28899.4 29568.0 35455.6 36893.4 37340.0 37390.6 37423.0 9917.6 9935.6 10142.2 10352.0 10354.3 10748.6 10850.3 10928.1 11163.3 11182.3 9723.1 10455.9 10467.2 10569.2 10766.8 10046.5 10128.7 10389.2 10612.6 10761.7 10121.5 10178.3 10220.7 10422.5 10572.8 8609.7 8932.5 8939.2 9110.1 9155.9 8658.3 8708.6 8968.1 9117.0 9140.8 04:43:11 INFO - PROCESS | 12607 | -------- Summary: end -------- 04:43:11 INFO - PROCESS | 12607 | 04:43:12 INFO - TEST-INFO | 12607: exit 0 04:43:12 INFO - TEST-OK | dromaeo_css | took 1117792ms 04:43:12 INFO - TEST-START | kraken 04:43:12 INFO - operating with platform_type : linux_ 04:43:12 INFO - Initialising browser for kraken test... 04:43:12 INFO - TEST-INFO | started process 12785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDVA14s/profile http://localhost:42902/getInfo.html) 04:43:17 INFO - PROCESS | 12785 | __metrics Screen width/height:1600/1200 04:43:17 INFO - PROCESS | 12785 | colorDepth:24 04:43:17 INFO - PROCESS | 12785 | Browser inner width/height: 1024/697 04:43:17 INFO - PROCESS | 12785 | __metrics 04:43:18 ERROR - PROCESS | 12785 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:43:18 INFO - TEST-INFO | 12785: exit 0 04:43:18 INFO - Browser initialized. 04:43:18 INFO - Running cycle 1/1 for kraken test... 04:43:18 INFO - TEST-INFO | started process 12868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDVA14s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:30 INFO - PROCESS | 12868 | RSS: Main: 156856320 04:43:30 INFO - PROCESS | 12868 | 04:43:33 INFO - PROCESS | 12868 | Cycle 1(1): loaded http://localhost:42902/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42902/tests/kraken/driver.html?testName=audio-beat-detection) 04:43:34 INFO - PROCESS | 12868 | RSS: Main: 210849792 04:43:34 INFO - PROCESS | 12868 | 04:43:37 INFO - PROCESS | 12868 | Cycle 1(1): loaded http://localhost:42902/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42902/tests/kraken/driver.html?testName=audio-dft) 04:43:38 INFO - PROCESS | 12868 | RSS: Main: 196812800 04:43:38 INFO - PROCESS | 12868 | 04:43:41 INFO - PROCESS | 12868 | Cycle 1(1): loaded http://localhost:42902/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42902/tests/kraken/driver.html?testName=audio-fft) 04:43:41 INFO - PROCESS | 12868 | RSS: Main: 267120640 04:43:41 INFO - PROCESS | 12868 | 04:43:43 INFO - PROCESS | 12868 | Cycle 1(1): loaded http://localhost:42902/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42902/tests/kraken/driver.html?testName=audio-oscillator) 04:43:44 INFO - PROCESS | 12868 | RSS: Main: 175656960 04:43:44 INFO - PROCESS | 12868 | 04:43:46 INFO - PROCESS | 12868 | Cycle 1(1): loaded http://localhost:42902/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42902/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:43:47 INFO - PROCESS | 12868 | RSS: Main: 179806208 04:43:47 INFO - PROCESS | 12868 | 04:43:50 INFO - PROCESS | 12868 | Cycle 1(1): loaded http://localhost:42902/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42902/tests/kraken/driver.html?testName=imaging-darkroom) 04:43:51 INFO - PROCESS | 12868 | RSS: Main: 215928832 04:43:51 INFO - PROCESS | 12868 | 04:43:54 INFO - PROCESS | 12868 | Cycle 1(1): loaded http://localhost:42902/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42902/tests/kraken/driver.html?testName=imaging-desaturate) 04:43:55 INFO - PROCESS | 12868 | RSS: Main: 213712896 04:43:55 INFO - PROCESS | 12868 | 04:43:58 INFO - PROCESS | 12868 | Cycle 1(1): loaded http://localhost:42902/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42902/tests/kraken/driver.html?testName=json-parse-financial) 04:43:58 INFO - PROCESS | 12868 | RSS: Main: 215314432 04:43:58 INFO - PROCESS | 12868 | 04:44:00 INFO - PROCESS | 12868 | Cycle 1(1): loaded http://localhost:42902/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42902/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:44:01 INFO - PROCESS | 12868 | RSS: Main: 201777152 04:44:01 INFO - PROCESS | 12868 | 04:44:02 INFO - PROCESS | 12868 | Cycle 1(1): loaded http://localhost:42902/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42902/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:44:03 INFO - PROCESS | 12868 | RSS: Main: 203141120 04:44:03 INFO - PROCESS | 12868 | 04:44:05 INFO - PROCESS | 12868 | Cycle 1(1): loaded http://localhost:42902/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42902/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:44:06 INFO - PROCESS | 12868 | RSS: Main: 216887296 04:44:06 INFO - PROCESS | 12868 | 04:44:09 INFO - PROCESS | 12868 | Cycle 1(1): loaded http://localhost:42902/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:44:09 INFO - PROCESS | 12868 | RSS: Main: 219463680 04:44:09 INFO - PROCESS | 12868 | 04:44:12 INFO - PROCESS | 12868 | Cycle 1(1): loaded http://localhost:42902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:44:13 INFO - PROCESS | 12868 | RSS: Main: 218660864 04:44:13 INFO - PROCESS | 12868 | 04:44:15 INFO - PROCESS | 12868 | Cycle 1(1): loaded http://localhost:42902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42902/tests/kraken/driver.html?testName=ai-astar) 04:44:15 INFO - PROCESS | 12868 | RSS: Main: 281735168 04:44:15 INFO - PROCESS | 12868 | 04:44:15 INFO - PROCESS | 12868 | __start_tp_report 04:44:15 INFO - PROCESS | 12868 | _x_x_mozilla_page_load 04:44:15 INFO - PROCESS | 12868 | _x_x_mozilla_page_load_details 04:44:15 INFO - PROCESS | 12868 | |i|pagename|runs| 04:44:15 INFO - PROCESS | 12868 | |0;ai-astar;112;116;109;114;114;114;104;113;114;114 04:44:15 INFO - PROCESS | 12868 | |1;audio-beat-detection;164;132;160;200;139;153;157;132;188;133 04:44:15 INFO - PROCESS | 12868 | |2;audio-dft;161;160;161;168;161;161;161;161;161;163 04:44:15 INFO - PROCESS | 12868 | |3;audio-fft;77;78;106;109;79;74;77;113;105;73 04:44:15 INFO - PROCESS | 12868 | |4;audio-oscillator;95;94;144;95;94;94;141;96;95;143 04:44:15 INFO - PROCESS | 12868 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;116 04:44:15 INFO - PROCESS | 12868 | |6;imaging-darkroom;148;146;147;147;146;147;148;147;147;147 04:44:15 INFO - PROCESS | 12868 | |7;imaging-desaturate;94;95;94;95;95;94;94;95;95;95 04:44:15 INFO - PROCESS | 12868 | |8;json-parse-financial;66;66;67;67;67;67;75;90;66;65 04:44:15 INFO - PROCESS | 12868 | |9;json-stringify-tinderbox;65;65;65;65;65;64;64;63;65;64 04:44:15 INFO - PROCESS | 12868 | |10;stanford-crypto-aes;78;78;78;79;82;88;80;79;88;79 04:44:15 INFO - PROCESS | 12868 | |11;stanford-crypto-ccm;145;130;128;132;130;130;134;130;217;129 04:44:15 INFO - PROCESS | 12868 | |12;stanford-crypto-pbkdf2;179;178;173;178;174;176;174;176;172;173 04:44:15 INFO - PROCESS | 12868 | |13;stanford-crypto-sha256-iterative;75;72;74;73;72;73;74;73;71;72 04:44:15 INFO - PROCESS | 12868 | __end_tp_report 04:44:15 INFO - PROCESS | 12868 | __start_cc_report 04:44:15 INFO - PROCESS | 12868 | _x_x_mozilla_cycle_collect,1872 04:44:15 INFO - PROCESS | 12868 | __end_cc_report 04:44:15 INFO - PROCESS | 12868 | __startTimestamp1461584655339__endTimestamp 04:44:15 INFO - PROCESS | 12868 | 04:44:15 INFO - PROCESS | 12868 | ------- Summary: start ------- 04:44:15 INFO - PROCESS | 12868 | Number of tests: 14 04:44:15 INFO - PROCESS | 12868 | 04:44:15 INFO - PROCESS | 12868 | [#0] ai-astar Cycles:10 Average:112.40 Median:114.00 stddev:3.47 (3.0%) stddev-sans-first:3.68 04:44:15 INFO - PROCESS | 12868 | Values: 112.0 116.0 109.0 114.0 114.0 114.0 104.0 113.0 114.0 114.0 04:44:15 INFO - PROCESS | 12868 | 04:44:15 INFO - PROCESS | 12868 | [#1] audio-beat-detection Cycles:10 Average:155.80 Median:158.50 stddev:23.62 (14.9%) stddev-sans-first:24.86 04:44:15 INFO - PROCESS | 12868 | Values: 164.0 132.0 160.0 200.0 139.0 153.0 157.0 132.0 188.0 133.0 04:44:15 INFO - PROCESS | 12868 | 04:44:15 INFO - PROCESS | 12868 | [#2] audio-dft Cycles:10 Average:161.80 Median:161.00 stddev:2.30 (1.4%) stddev-sans-first:2.42 04:44:15 INFO - PROCESS | 12868 | Values: 161.0 160.0 161.0 168.0 161.0 161.0 161.0 161.0 161.0 163.0 04:44:15 INFO - PROCESS | 12868 | 04:44:15 INFO - PROCESS | 12868 | [#3] audio-fft Cycles:10 Average:89.10 Median:75.50 stddev:16.70 (22.1%) stddev-sans-first:17.13 04:44:15 INFO - PROCESS | 12868 | Values: 77.0 78.0 106.0 109.0 79.0 74.0 77.0 113.0 105.0 73.0 04:44:15 INFO - PROCESS | 12868 | 04:44:15 INFO - PROCESS | 12868 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:94.50 stddev:23.18 (24.5%) stddev-sans-first:24.02 04:44:15 INFO - PROCESS | 12868 | Values: 95.0 94.0 144.0 95.0 94.0 94.0 141.0 96.0 95.0 143.0 04:44:15 INFO - PROCESS | 12868 | 04:44:15 INFO - PROCESS | 12868 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:44:15 INFO - PROCESS | 12868 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 04:44:15 INFO - PROCESS | 12868 | 04:44:15 INFO - PROCESS | 12868 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 04:44:15 INFO - PROCESS | 12868 | Values: 148.0 146.0 147.0 147.0 146.0 147.0 148.0 147.0 147.0 147.0 04:44:15 INFO - PROCESS | 12868 | 04:44:15 INFO - PROCESS | 12868 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:44:15 INFO - PROCESS | 12868 | Values: 94.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 04:44:15 INFO - PROCESS | 12868 | 04:44:15 INFO - PROCESS | 12868 | [#8] json-parse-financial Cycles:10 Average:69.60 Median:67.00 stddev:7.69 (11.5%) stddev-sans-first:8.05 04:44:15 INFO - PROCESS | 12868 | Values: 66.0 66.0 67.0 67.0 67.0 67.0 75.0 90.0 66.0 65.0 04:44:15 INFO - PROCESS | 12868 | 04:44:15 INFO - PROCESS | 12868 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 04:44:15 INFO - PROCESS | 12868 | Values: 65.0 65.0 65.0 65.0 65.0 64.0 64.0 63.0 65.0 64.0 04:44:15 INFO - PROCESS | 12868 | 04:44:15 INFO - PROCESS | 12868 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:79.50 stddev:3.93 (4.9%) stddev-sans-first:4.02 04:44:15 INFO - PROCESS | 12868 | Values: 78.0 78.0 78.0 79.0 82.0 88.0 80.0 79.0 88.0 79.0 04:44:15 INFO - PROCESS | 12868 | 04:44:15 INFO - PROCESS | 12868 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:131.00 stddev:27.32 (20.9%) stddev-sans-first:28.93 04:44:15 INFO - PROCESS | 12868 | Values: 145.0 130.0 128.0 132.0 130.0 130.0 134.0 130.0 217.0 129.0 04:44:15 INFO - PROCESS | 12868 | 04:44:15 INFO - PROCESS | 12868 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:176.00 stddev:2.45 (1.4%) stddev-sans-first:2.20 04:44:15 INFO - PROCESS | 12868 | Values: 179.0 178.0 173.0 178.0 174.0 176.0 174.0 176.0 172.0 173.0 04:44:15 INFO - PROCESS | 12868 | 04:44:15 INFO - PROCESS | 12868 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:73.00 stddev:1.20 (1.6%) stddev-sans-first:1.00 04:44:15 INFO - PROCESS | 12868 | Values: 75.0 72.0 74.0 73.0 72.0 73.0 74.0 73.0 71.0 72.0 04:44:15 INFO - PROCESS | 12868 | -------- Summary: end -------- 04:44:15 INFO - PROCESS | 12868 | 04:44:16 INFO - TEST-INFO | 12868: exit 0 04:44:16 INFO - TEST-OK | kraken | took 63528ms 04:44:16 INFO - SUITE-END | took 1181s 04:44:16 INFO - Completed test suite (00:19:41) 04:44:16 INFO - javascript benchmark 04:44:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.5041942031016, 2679.2498100531857, 2685.3957859481607, 2692.2192564156408, 2722.782177425806, 4518.480374756904, 4645.674802763808, 4663.65022623303, 4675.275332323491, 4696.788644511001, 4595.747233902134, 4653.767311634413, 4654.790534425951, 4684.250519916814, 4697.85906422807, 4242.236397448458, 4272.081502476967, 4274.337477690948, 4318.632916202127, 4353.978230108845, 4232.53442121368, 4361.629261512775, 4393.319035549479, 4416.984093658461, 4432.734035957837, 4343.9348409773875, 4349.3475978603465, 4369.1916995355805, 4385.2106620808245, 4435.866923992286, 4194.643455306303, 4278.272693642089, 4281.7002809803325, 4282.743035417885, 4365.170617582649, 4231.682623803227, 4282.700210985232, 4308.80610372534, 4312.82748690052, 4343.565643435662, 4569.0, 4596.4254468191475, 4610.377599024156, 4611.700239484423, 4637.188492013884, 4880.048390563841, 4894.36373271476, 4931.630127740434, 4977.402711674622, 4982.451930287665, 4955.529224723646, 4956.553910148104, 4970.105381031449, 4970.850874473772, 4996.775145118479, 4464.531224221475, 4627.514111018295, 4629.305604159369, 4629.768511574408, 4648.604868586141, 5090.0, 5177.326947496801, 5194.97402512985, 5200.557952574073, 5212.765425555859, 4887.364642596511, 4911.729854857946, 4915.680480768739, 4922.335484709519, 4961.776720047535, 4971.080350135237, 4982.8754281143265, 4985.177445721415, 4985.975070124626, 5037.269595908646, 4778.976105119452, 4896.314515967767, 4944.950550494521, 4970.304157417892, 4993.525615066563, 4938.061768264019, 4951.3810773653295, 4965.131102057126, 4968.403791545038, 5020.548150666385, 4122.91754164915, 4228.640565551901, 4238.830446782094, 4246.554111818215, 4294.6993710439965, 3673.540807399075, 3687.8524859005875, 3715.2569486102348, 3754.6996240301255, 3777.131259810204, 4281.571842815693, 4305.203537345601, 4308.482982042112, 4337.327714204303, 4360.127974405068, 4919.704817710949, 4938.407391113017, 4962.106820772224, 4966.776495057731, 5017.724025178651, 4302.3546468030045, 4334.653227741773, 4337.9132417351475, 4349.717268377545, 4372.366006928977, 4481.619062379734, 4508.1659892919915, 4519.480259770168, 4530.4110465639915, 4553.886152846206, 4567.771611419482, 4720.457147427953, 4742.241241401497, 4745.525447455227, 4750.809967601326, 4929.704217746947, 4936.75316234194, 4948.851534453972, 4974.651774375904, 4998.6750861193905, 4658.883527911829, 4660.324252983366, 4661.230896901973, 4672.439307283012, 4718.433787945469, 4726.740029298284, 4791.832285869978, 4866.416030076413, 4900.583450406755, 4933.235348520985, 4906.975465122794, 4916.139675556692, 4922.630802689741, 4951.9257211142585, 4964.230544265644, 4825.782839772149, 4826.7827947743135, 4831.661783675109, 4880.048390563806, 4880.389951256093, 4767.165745994506, 4780.163471392562, 4839.201531747222, 4878.463369029333, 4886.047220791911, 4741.193997020446, 4761.119192949315, 4776.689515181641, 4793.640476964172, 4817.181079216612, 4855.053264613366, 4855.587275081658, 4870.829520966749, 4878.219484882402, 4907.5828554571835, 4674.22875225584, 4706.811727530998, 4800.039992001543, 4801.1117943180625, 4812.470628230962], "value": 4576.853636288925, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.6050255574929, 609.5854818723269, 609.9725512351944, 627.6046090962693, 628.2555172121034, 26550.6017409739, 34957.0, 35877.0, 35897.0, 35902.46146307808, 38215.0, 38849.22301553974, 38884.0, 38936.22127557454, 39023.80488097563, 7647.502912310696, 7847.843043139133, 7848.45060845741, 7850.450468467209, 7854.136045035041, 7634.50375725576, 7743.18696536864, 7761.883571746428, 7766.068071831388, 7770.33952114071, 7952.324052455549, 7990.360771138324, 8021.799455013642, 8025.036995560512, 8026.478278911881, 7857.764267071969, 7917.445778795458, 7954.0, 7964.283214510664, 7966.5618390988475, 7833.804154896116, 7945.602719863984, 7946.324562412202, 7948.364130869517, 7948.721794737215, 37916.24167516634, 38411.03972400684, 38467.23065538674, 38554.228915421816, 38657.61342386568, 2931.6042334285025, 2948.8378139202337, 3005.5040918248465, 3104.161876293388, 3580.534530511017, 26625.600615990777, 27068.59397109045, 28961.0, 29188.854055729797, 30003.0, 3304.7851889627095, 3411.1301618087227, 3425.5718035245595, 3476.356873978297, 3564.3940530109944, 162769.0, 165700.0, 166358.0, 167070.0, 167849.16075419544, 47881.0, 48085.0, 48280.0, 48375.75812120917, 48398.516014840105, 50254.74872625613, 50418.0, 50738.23892641613, 51706.22440663393, 51877.74061129746, 14625.78061329081, 14809.407623695148, 14869.553913382615, 14876.92561537207, 14889.255537223313, 11224.382658953837, 11271.492782824793, 11272.380019098864, 11284.830727539094, 11294.774104517863, 17513.824861751218, 17636.47090587259, 17654.823451765576, 17679.823201768075, 17732.20205090774, 6689.632070236184, 7032.12098487689, 7083.433325333961, 7130.928690713026, 7161.0, 824.118193532926, 830.2022185235794, 889.7908991387019, 909.4316052467208, 918.7932715139174, 28247.717522824507, 28641.57037644437, 28756.386725532102, 28827.711722882923, 29104.0, 873.991260087391, 933.2580598424133, 945.9054094590485, 954.1365064616533, 993.5330394714473, 15114.773278400833, 15157.924210378878, 15309.923450382677, 15549.144797036271, 15645.061296322257, 312253.0, 319126.0, 319926.0, 320347.0, 320945.0, 48365.032699345815, 48632.5136748628, 48838.5116148834, 49013.0, 49097.10834699859, 1170.3212136960542, 1181.7695549367963, 1191.6722901202413, 1208.5528354508888, 1304.8434187897324, 24921.875390622932, 26012.73987260179, 26574.335641609116, 26637.866810665822, 26688.466230675665, 35895.46156807702, 36123.819380902925, 36135.0, 36181.457278140326, 36189.0, 182158.0, 182477.0, 183297.0, 183410.0, 183508.0, 20777.0, 20971.0, 21484.14063437445, 23871.403214919766, 23996.76003240015, 35656.82171589125, 37215.441768372955, 37241.81379093087, 37926.810365948, 38410.0397490065, 31506.842465787526, 32878.671213288515, 33169.170770730925, 33509.83245083759, 33622.159446013065, 32481.0, 32847.178820529676, 32999.17502062372, 33144.668553315125, 33161.0, 32746.672533274363, 33010.367164164294, 33283.167920802174, 34998.65001349954, 35194.29611407809, 30489.23776905595, 31772.205694857814, 32185.678143219204, 32227.838860805547, 32449.675503244664, 24134.155304564258, 24576.87711561431, 24805.00779968781, 24999.500289832216, 25093.87453062723], "value": 16502.561334316204, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.0542596222424, 380.20157668895325, 381.3307645082879, 381.40881633468115, 382.50274642964155, 15836.445724399648, 16189.0, 17104.31582736689, 17106.486805395827, 17135.228914698837, 11891.989180919632, 15503.147326897017, 16263.268152933117, 16269.51191464255, 16284.348626054973, 4630.953690463103, 4749.430068391798, 4790.257510085942, 4797.112534181188, 4804.543568361, 3478.200013996782, 4641.443026836784, 5109.208072748711, 5387.946120538803, 5407.702576358299, 5371.81198658047, 5390.703511306877, 5395.81114660987, 5409.7295135243085, 5411.107167317388, 5029.1450453423, 5316.9734151329385, 5323.973380133075, 5327.174287985368, 5434.7826086956475, 3369.8146601936883, 4927.6304277179, 5177.45636708144, 5191.662541934762, 5193.428722840485, 11693.649190524298, 11820.940895295555, 11880.821787673192, 12665.0, 19782.0, 1677.429673910864, 1720.8623310135158, 1867.0104844432472, 1871.4479228627588, 1926.0851095729556, 8663.176998185163, 8985.955070224672, 9012.77468063297, 9018.278537717033, 9110.0, 1646.4319809665647, 1662.709025920459, 1668.9165541722987, 1720.5440558252074, 1732.488915769851, 63039.36960630381, 64003.0, 66711.33288667149, 67819.3218067818, 70026.64986675086, 10050.296479246528, 10081.294309398418, 10099.596016159272, 10174.949125254327, 10271.126954208827, 14246.287685615678, 14266.3580138894, 14342.713145737027, 14346.856531434552, 14363.712725745427, 6911.274316196827, 7100.396466300319, 7136.143662760502, 7177.605231712306, 7212.0, 6667.0, 6680.498962577826, 6720.798376048726, 6732.663366831737, 6899.862002759916, 4337.175936572041, 4384.167008268419, 4410.845620403271, 4411.492678341968, 4459.0858873930765, 1682.6634673065437, 1809.6561653285833, 1825.3611236067536, 1879.2483006797117, 1929.2572359641358, 822.7490615362371, 832.3466079127855, 836.510641274861, 883.6597909804772, 891.7948871759531, 15842.60393490172, 16147.596310092342, 16921.661566768595, 17050.23273952675, 17277.913610431868, 824.4517395931758, 836.8953880764905, 902.5306840442933, 903.7379160043514, 933.5472295936465, 9128.634854605874, 9139.908600913906, 9381.0, 9832.508374581384, 9846.507674616383, 359737.0, 362090.0, 362675.0, 362835.0, 363063.0, 73553.26446735571, 76119.23880761232, 77473.61263193648, 77868.0, 78378.6081069591, 947.9952600237093, 954.2938225712923, 972.9513524323755, 977.5454413697664, 986.8371718666483, 15244.695106097593, 15270.312835922188, 15372.154531500428, 15464.5360639181, 15678.686426271639, 32675.509867352484, 33254.836080737055, 34373.48439773455, 34426.311473769885, 34796.0, 46343.53656463527, 46524.53475465202, 47476.28785568288, 48290.0, 48359.758201208766, 7299.781006569599, 7356.0, 7370.22612625688, 7423.777286681408, 7482.289182527651, 7791.065072191147, 11140.275882067639, 11447.0, 11486.0, 11910.0, 9915.30592858493, 10161.136303414292, 10266.58933642646, 10357.896421035995, 10401.94799026, 5028.547430731252, 8270.214329638675, 9573.468245081032, 10207.489625518843, 10567.788644227227, 10086.092251697382, 10132.64535741275, 10704.571817127227, 11054.170937179582, 11172.385518796544, 7598.506097103671, 7860.528368297921, 7890.842183156419, 7919.326857217201, 8059.355251579742, 7906.16985216544, 9549.283803714889, 10302.278840481094, 10668.946655266674, 10756.946215268874], "value": 7883.367730033366, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1208.8972437342825, 1386.0782579584577, 1446.732354514415, 1489.158625376662, 1675.170790458723, 6419.454346380558, 7387.18740938497, 7670.846583068335, 7680.347170490515, 7685.154632990374, 7441.107067151936, 7570.394368450511, 7579.886301705479, 7586.127595326539, 7592.050993625797, 1859.860510461714, 1914.7606549181353, 1916.7412399326122, 2169.6420090685056, 2211.5466329402434, 2184.388371256051, 2254.966175507369, 2266.889224280099, 2270.8523945943543, 2279.122537822942, 2121.4378189779723, 2149.9032543535577, 2161.016737384486, 2162.5350549631826, 2216.567769284982, 1893.195391958426, 2110.472381904524, 2139.208492857637, 2146.9463263418384, 2150.161437039548, 2144.9892750536305, 2169.1323470611724, 2172.5546263016045, 2173.1850556041486, 2175.0973346061523, 7377.114746230433, 7418.146913105008, 7426.257374262585, 7438.293362130589, 7454.329110380092, 4452.510223875371, 4595.586397224266, 4596.54034596541, 4603.309503574457, 4603.424571928509, 2806.0599699100826, 2900.5794159846914, 2908.9854550727323, 2915.3440475892967, 2916.970830291691, 854.4104567848165, 872.0930232558131, 879.6393478673778, 887.671561522241, 921.6037104045258, 10226.744331391701, 10234.744131396774, 10243.385396876136, 10254.436006019667, 10263.486825658762, 4194.937075943863, 4301.913961720748, 4345.8261669533495, 4380.277254253013, 4391.494978077498, 8762.38663293576, 8848.336374771918, 8860.335474839283, 8867.423617464845, 8874.334424918157, 4690.530946905282, 4703.576678098988, 4705.482396936334, 4712.858614241578, 4721.504242054603, 3592.4431713084514, 3965.841366345314, 4158.4178215049915, 4175.123224122968, 4209.0, 3604.2611264690677, 3698.4082546792383, 3717.9628203717616, 3744.213715119801, 3832.4442955771256, 1181.0846593889805, 1209.915305928594, 1223.5411720604773, 1233.9506419743288, 1236.7279198576298, 811.6972259523498, 819.3690858039276, 829.5989774247554, 854.5043874552745, 859.1408591408591, 4891.877703057381, 5008.223725322581, 5053.292539044537, 5086.796528138907, 5123.180291153398, 401.6886912642725, 407.5415157947309, 411.96498297645036, 413.6153377359025, 414.66619371405704, 3381.5434916286476, 3414.214730611973, 3414.778039427429, 3448.74134439913, 3492.336456073338, 8997.505137217386, 9116.81766364669, 9305.25557955362, 9469.053094690476, 9470.763230919281, 9302.069793020779, 9349.766255843522, 9376.296777741696, 9394.483303418241, 9427.387219830689, 6990.056342393814, 7147.2138064812825, 7227.747028853965, 7295.124585049722, 7298.489105762652, 4954.157793175241, 4974.129527332775, 5005.224190250517, 5145.742712864417, 5171.120909445479, 8460.407771455939, 8653.69712060075, 8655.52394618302, 8683.478991260545, 8716.912830871865, 8419.83160336802, 8559.272461840565, 8636.352273579381, 8738.43200192011, 8817.515036673045, 5966.224390829165, 6311.873762524816, 6487.54587178893, 6558.737650494118, 6741.157355330583, 7276.272372762682, 7284.417246620364, 7327.816804579928, 7331.74338898136, 7356.043714317105, 5949.940500594938, 6415.294317624965, 6465.353464653497, 6478.028295755675, 6584.374484423972, 6321.810345689637, 6385.808425747235, 6436.388543088399, 6456.031595260749, 6489.805305840832, 5686.943130568641, 5809.796657116981, 5821.76712931478, 5822.097574875901, 5837.532997360286, 4341.739495630146, 4364.585364390377, 4390.736555806662, 4405.38324634545, 4430.560067977855, 4308.332208507686, 4384.364267181305, 4419.977900110479, 4450.755208463565, 4482.282834746425], "value": 3953.675616795541, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.8703396437639, 300.0458541836958, 301.1312363830349, 306.94628440023007, 307.75533450906534, 4672.883177920554, 4685.0, 4704.835330763424, 4749.596284315833, 4765.904681906364, 4384.693071484998, 4505.526919673436, 4549.522300158485, 4639.7912093955765, 4675.509071547481, 3709.9443508347395, 3735.8879233622897, 3755.5868854426126, 3758.981205093971, 3767.1523907120886, 3730.601024615769, 3762.6613604775566, 3764.9435258471144, 3770.095177157476, 3775.9056023599355, 3533.275678485917, 3604.945925811115, 3728.403455447129, 3740.8316625751772, 3755.9624403756025, 3710.4619830124752, 3713.9071523211865, 3722.311372396102, 3727.8816355093636, 3747.938633751453, 3320.2197483591335, 3325.983370083134, 3327.916802079943, 3332.583427071616, 3342.4484959981573, 4401.845935392246, 4484.641228701728, 4526.977365113154, 4539.773011349453, 4539.909201815945, 4208.3687446882905, 4219.9578004219875, 4239.300515414983, 4256.34026725858, 4264.509581398148, 4834.3473631059705, 4851.466338702739, 4856.660033797635, 4883.658143929926, 4890.413150421937, 3584.6415358464205, 3596.7122630189524, 3599.5680518337967, 3608.711303095746, 3616.566012078541, 4875.780589873464, 5067.986402719471, 5087.745612719386, 5119.616028797818, 5129.153689641204, 3674.4488326751202, 3697.852085916587, 3699.9075023124637, 3701.40777475608, 3703.2223233121344, 3729.9813500932864, 3746.662800347982, 3764.5294338207723, 3764.661180493769, 3791.563970143414, 3899.757639357381, 4163.521195062546, 4211.873643790691, 4222.704410691222, 4225.302825033897, 4846.224604063404, 4897.191963326082, 4901.901961960741, 4915.778789954461, 4926.507349265116, 1246.9438875250635, 1275.4196840437578, 1304.7651422743998, 1308.4373719300793, 1314.789633658629, 879.5426378283385, 885.526243459746, 902.366716243588, 909.1590278991906, 912.4160537256162, 4618.35343051973, 4620.897491641295, 4638.466576343696, 4644.303354496852, 4649.651276154302, 5322.3879253885525, 5323.866903327448, 5342.492463215988, 5358.16948372995, 5361.892762144813, 4510.684252102387, 4572.382728331632, 4628.143793398165, 4628.634552806862, 4638.0, 2836.6737825149958, 2842.2041828287697, 2852.6434195725533, 2855.2433605094666, 2861.699521550249, 5041.621878359065, 5085.618578606619, 5109.412417572027, 5117.744112794346, 5118.488151184852, 5295.761690723926, 5482.588805839578, 5484.862878428071, 5487.670739755627, 5509.972450137724, 5037.143685573388, 5041.445441001413, 5057.519535644108, 5083.339165908408, 5106.106431374569, 5338.225957236256, 5361.544268737201, 5363.678179309254, 5371.785128594969, 5378.327709036371, 4711.8822029448165, 4933.9506604933495, 5011.1709226132925, 5213.191955246943, 5226.2230841514065, 4787.736674482937, 4858.902821943612, 4869.415670119608, 4869.926951095807, 4886.753877761148, 3665.871694490787, 3724.6534683149443, 3733.8693145739767, 3753.812309384465, 3754.305453491113, 4822.156122678447, 4990.426100998432, 5031.9181376004335, 5089.92365114531, 5119.078565858182, 4770.618350532019, 4858.392700912386, 4935.259711043373, 4951.331570238116, 4996.800127994839, 4912.729799861042, 4915.361003069578, 4941.357623508921, 4986.177280748636, 4990.128701736849, 4638.443386793607, 4845.9757701211265, 4883.633727470383, 4893.21708526634, 4898.167311556973, 4981.626378021735, 4989.0, 4991.950080499294, 5002.52476014778, 5022.899542009212, 4846.660733748604, 4852.781624826821, 4902.411710594752, 4910.361652985232, 4912.189488734319], "value": 3797.3725197840854, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.5703150373498, 752.8983587215724, 755.9886601700972, 768.5158350239349, 780.8126049748062, 11671.0, 11798.1151413644, 11887.22733022353, 12093.879061209385, 12107.757844843098, 11607.535698572046, 12198.939005304961, 12217.450214740336, 12244.081693872973, 12246.632601021962, 638.4190386748037, 786.7246463737703, 796.0208943000099, 805.9838803223932, 822.383212590557, 816.7672213419177, 819.4755356571799, 819.774561995453, 821.0434843407423, 821.4003777242616, 844.8014716541608, 845.5434065604566, 846.0777752250046, 848.8854004709347, 849.0109022988212, 664.1598378051768, 827.5076329583887, 845.5729856422498, 855.0807881527383, 856.3277826905849, 616.4575173846986, 620.2030390947656, 624.1729708136692, 625.383996763188, 625.4621025917708, 12233.143679942408, 12270.509179632803, 12293.139480236387, 12334.198277111958, 12362.567310144103, 11590.710232244177, 11918.642440726706, 11950.701232469171, 12133.21134126279, 12261.632151035394, 9675.70972870815, 9793.167580755644, 9943.850842237372, 9984.301098923079, 10021.59913603455, 3293.967060329414, 3347.7656564040526, 3368.562086928708, 3448.74134439918, 3468.3930312195266, 42030.0, 42143.789281053396, 42151.7892410536, 42208.0, 44335.113297734184, 9907.851382229272, 9932.503374831374, 9986.650467233758, 10067.345622534513, 10125.949370253102, 17978.460646180636, 18062.909685451752, 18079.63840723178, 18097.638047239245, 18133.546661333574, 6569.80290591283, 6652.0, 6683.298253683391, 6697.832554186184, 6858.211305699809, 3536.504889315498, 3554.87557935471, 3623.909402264912, 3676.816159192083, 3712.0348709335767, 2765.198092553137, 2830.3348713052414, 2832.107886015898, 2832.603435519029, 2836.971630283671, 405.36155555000994, 463.8793913582493, 487.12317827909624, 487.7853744352474, 544.5317027356471, 531.9069162896556, 567.7473524281655, 568.2158621102851, 590.3771521045338, 601.5338112962489, 6851.897221541681, 7075.186353569303, 7094.326039026284, 7255.238199988925, 7264.491485595958, 555.0785695745044, 555.908513341804, 556.7605929450294, 573.4609467100995, 587.0724255676022, 3484.77348972316, 3550.822458877046, 3573.4639804029084, 3658.3049220648522, 3684.6499582539614, 44142.77928610337, 48690.0, 48821.51178488241, 48860.267095993586, 52817.2077418839, 42079.7896010518, 42435.15129697389, 44534.33198502025, 45373.773131134134, 45638.0, 40491.39262911059, 41119.1776164475, 41197.0, 41205.1758964819, 42113.15773684509, 7325.523840950321, 7377.8155546111775, 7394.741184058532, 7520.548767073993, 7528.661210245443, 28344.43311133807, 28363.57454638141, 28804.567931481462, 28899.422011560073, 29567.965121220655, 35455.64544354523, 36893.44659830158, 37340.0, 37390.62609373871, 37423.0, 9917.553710082919, 9935.552900119368, 10142.188624909842, 10352.0, 10354.275200735876, 10748.623798167027, 10850.29473084247, 10928.125749939827, 11163.330200188015, 11182.273152245078, 9723.124918757347, 10455.94772026135, 10467.162626989975, 10569.207309451976, 10766.838497422701, 10046.54790534413, 10128.746781330527, 10389.168866490814, 10612.628558000433, 10761.677149685522, 10121.544530495998, 10178.338408003456, 10220.693379198636, 10422.530986105796, 10572.788544229226, 8609.65561377538, 8932.460792728576, 8939.195472407515, 9110.088991101102, 9155.908440915506, 8658.307335413278, 8708.608112635073, 8968.148025937526, 9116.954415227881, 9140.782333508512], "value": 5735.944502906835, "unit": "score"}], "name": "dromaeo_css", "value": 6095.2942290670735, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 109.0, 114.0, 114.0, 114.0, 104.0, 113.0, 114.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 132.0, 160.0, 200.0, 139.0, 153.0, 157.0, 132.0, 188.0, 133.0], "value": 155.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 168.0, 161.0, 161.0, 161.0, 161.0, 161.0, 163.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 106.0, 109.0, 79.0, 74.0, 77.0, 113.0, 105.0, 73.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 144.0, 95.0, 94.0, 94.0, 141.0, 96.0, 95.0, 143.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 75.0, 90.0, 66.0, 65.0], "value": 69.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 63.0, 65.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 79.0, 82.0, 88.0, 80.0, 79.0, 88.0, 79.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 130.0, 128.0, 132.0, 130.0, 130.0, 134.0, 130.0, 217.0, 129.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 178.0, 173.0, 178.0, 174.0, 176.0, 174.0, 176.0, 172.0, 173.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 74.0, 73.0, 72.0, 73.0, 74.0, 73.0, 71.0, 72.0], "value": 72.9, "unit": "score"}], "name": "kraken", "value": 1590.3000000000002, "alertThreshold": 2.0}]} 04:44:16 INFO - Return code: 0 04:44:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:44:16 ERROR - # TBPL SUCCESS # 04:44:16 INFO - Running post-action listener: _resource_record_post_action 04:44:16 INFO - Running post-run listener: _resource_record_post_run 04:44:17 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 135168; Write bytes: 519053312; Read time: 24; Write time: 413484 04:44:17 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234102784; Read time: 0; Write time: 244740 04:44:17 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 135168; Write bytes: 278302720; Read time: 24; Write time: 167740 04:44:17 INFO - Running post-run listener: _upload_blobber_files 04:44:17 INFO - Blob upload gear active. 04:44:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:44:17 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:44:17 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:44:17 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:44:18 INFO - (blobuploader) - INFO - Open directory for files ... 04:44:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:44:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:44:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:18 INFO - (blobuploader) - INFO - Done attempting. 04:44:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:44:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:44:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:19 INFO - (blobuploader) - INFO - Done attempting. 04:44:19 INFO - (blobuploader) - INFO - Iteration through files over. 04:44:19 INFO - Return code: 0 04:44:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:44:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:44:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5dd3ffe583edf7efde1f16c379add99c25304b122b1b2555329721a5eb1578d85b1777608be511050935d2ea672acdbccffa8e52bf953636d473d57e6f9caaea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf529d1d5180afffc6b401995fb310f355bb9cbd15b1adceea077ffd479977bee32914ff31fd0c497888339baf9f92ce0c519e96763f7e350ff82901fa5c9764"} 04:44:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:44:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:44:19 INFO - Contents: 04:44:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5dd3ffe583edf7efde1f16c379add99c25304b122b1b2555329721a5eb1578d85b1777608be511050935d2ea672acdbccffa8e52bf953636d473d57e6f9caaea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf529d1d5180afffc6b401995fb310f355bb9cbd15b1adceea077ffd479977bee32914ff31fd0c497888339baf9f92ce0c519e96763f7e350ff82901fa5c9764"} 04:44:19 INFO - Running post-run listener: copy_logs_to_upload_dir 04:44:19 INFO - Copying logs to upload dir... 04:44:19 INFO - mkdir: /builds/slave/test/build/upload/logs 04:44:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.522789 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-25 04:44:19.365624) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 04:44:19.369392) ========= 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=574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5dd3ffe583edf7efde1f16c379add99c25304b122b1b2555329721a5eb1578d85b1777608be511050935d2ea672acdbccffa8e52bf953636d473d57e6f9caaea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf529d1d5180afffc6b401995fb310f355bb9cbd15b1adceea077ffd479977bee32914ff31fd0c497888339baf9f92ce0c519e96763f7e350ff82901fa5c9764"} build_url:https://queue.taskcluster.net/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011140 build_url: 'https://queue.taskcluster.net/v1/task/HSAFYax3T9CzCQ4eqBFB4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5dd3ffe583edf7efde1f16c379add99c25304b122b1b2555329721a5eb1578d85b1777608be511050935d2ea672acdbccffa8e52bf953636d473d57e6f9caaea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cf529d1d5180afffc6b401995fb310f355bb9cbd15b1adceea077ffd479977bee32914ff31fd0c497888339baf9f92ce0c519e96763f7e350ff82901fa5c9764"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 04:44:19.394783) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:44:19.395120) ========= 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=574dc5aafe09851ec43d388c000001b6-1461583420.911453-553721660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:44:19.478797) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 04:44:19.479099) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 04:44:19.479396) ========= ========= Total master_lag: 0.16 =========