builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1467240660.98 results: success (0) buildid: 20160629130426 builduid: a895d54ff7bf40d0a65922a67a781542 revision: ee43fafecf41bc2048b100e1fe2e272144884d19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:00.983969) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:00.984422) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:00.984781) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.005854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.006216) ========= 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=af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 15:51:01-- 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% 228M=0s 2016-06-29 15:51:01 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134465 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.160901) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.161723) ========= 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=af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020840 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.213495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.213949) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ee43fafecf41bc2048b100e1fe2e272144884d19 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ee43fafecf41bc2048b100e1fe2e272144884d19 --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=af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 15:51:01,367 truncating revision to first 12 chars 2016-06-29 15:51:01,367 Setting DEBUG logging. 2016-06-29 15:51:01,367 attempt 1/10 2016-06-29 15:51:01,367 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ee43fafecf41?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 15:51:01,662 unpacking tar archive at: mozilla-beta-ee43fafecf41/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645375 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.875497) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.875998) ========= script_repo_revision: ee43fafecf41bc2048b100e1fe2e272144884d19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.876432) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.876752) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.887613) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-29 15:51:01.888003) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:51:02 INFO - MultiFileLogger online at 20160629 15:51:02 in /builds/slave/test 15:51:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:51:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:51:02 INFO - {'append_to_log': False, 15:51:02 INFO - 'base_work_dir': '/builds/slave/test', 15:51:02 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:51:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:51:02 INFO - 'branch': 'Mozilla-Beta', 15:51:02 INFO - 'buildbot_json_path': 'buildprops.json', 15:51:02 INFO - 'config_files': ('talos/linux_config.py',), 15:51:02 INFO - 'default_actions': ('clobber', 15:51:02 INFO - 'read-buildbot-config', 15:51:02 INFO - 'download-and-extract', 15:51:02 INFO - 'populate-webroot', 15:51:02 INFO - 'create-virtualenv', 15:51:02 INFO - 'install', 15:51:02 INFO - 'run-tests'), 15:51:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:51:02 INFO - 'download_minidump_stackwalk': True, 15:51:02 INFO - 'download_symbols': 'ondemand', 15:51:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:51:02 INFO - 'tooltool.py': '/tools/tooltool.py', 15:51:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:51:02 INFO - '/tools/misc-python/virtualenv.py')}, 15:51:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:51:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:51:02 INFO - 'installer_path': 'installer.exe', 15:51:02 INFO - 'log_level': 'info', 15:51:02 INFO - 'log_name': 'talos', 15:51:02 INFO - 'log_to_console': True, 15:51:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:51:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:51:02 INFO - 'opt_config_files': (), 15:51:02 INFO - 'pip_index': False, 15:51:02 INFO - 'sps_profile': False, 15:51:02 INFO - 'sps_profile_interval': 0, 15:51:02 INFO - 'suite': 'dromaeojs', 15:51:02 INFO - 'system_bits': '32', 15:51:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:51:02 INFO - 'title': 'talos-linux64-ix-020', 15:51:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:51:02 INFO - 'use_talos_json': True, 15:51:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:51:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:51:02 INFO - 'work_dir': 'build'} 15:51:02 INFO - ##### 15:51:02 INFO - ##### Running clobber step. 15:51:02 INFO - ##### 15:51:02 INFO - Running pre-action listener: _resource_record_pre_action 15:51:02 INFO - Running main action method: clobber 15:51:02 INFO - rmtree: /builds/slave/test/build 15:51:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:51:03 INFO - Running post-action listener: _resource_record_post_action 15:51:03 INFO - ##### 15:51:03 INFO - ##### Running read-buildbot-config step. 15:51:03 INFO - ##### 15:51:03 INFO - Running pre-action listener: _resource_record_pre_action 15:51:03 INFO - Running main action method: read_buildbot_config 15:51:03 INFO - Using buildbot properties: 15:51:03 INFO - { 15:51:03 INFO - "project": "", 15:51:03 INFO - "product": "firefox", 15:51:03 INFO - "script_repo_revision": "production", 15:51:03 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 15:51:03 INFO - "repository": "", 15:51:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 15:51:03 INFO - "buildid": "20160629130426", 15:51:03 INFO - "pgo_build": "True", 15:51:03 INFO - "basedir": "/builds/slave/test", 15:51:03 INFO - "buildnumber": 76, 15:51:03 INFO - "slavename": "talos-linux64-ix-020", 15:51:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:51:03 INFO - "platform": "ubuntu64_hw", 15:51:03 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:51:03 INFO - "branch": "mozilla-beta", 15:51:03 INFO - "repo_path": "releases/mozilla-beta", 15:51:03 INFO - "revision": "ee43fafecf41bc2048b100e1fe2e272144884d19", 15:51:03 INFO - "stage_platform": "linux64-pgo", 15:51:03 INFO - "builduid": "a895d54ff7bf40d0a65922a67a781542", 15:51:03 INFO - "slavebuilddir": "test" 15:51:03 INFO - } 15:51:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 15:51:03 INFO - Running post-action listener: _resource_record_post_action 15:51:03 INFO - ##### 15:51:03 INFO - ##### Running download-and-extract step. 15:51:03 INFO - ##### 15:51:03 INFO - Running pre-action listener: _resource_record_pre_action 15:51:03 INFO - Running main action method: download_and_extract 15:51:03 INFO - mkdir: /builds/slave/test/build/tests 15:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:03 INFO - https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:51:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:51:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:51:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:51:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:51:08 INFO - Downloaded 1327 bytes. 15:51:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:51:08 INFO - Using the following test package requirements: 15:51:08 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 15:51:08 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:51:08 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:51:08 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:51:08 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 15:51:08 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:51:08 INFO - u'jsshell-linux-x86_64.zip'], 15:51:08 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:51:08 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:51:08 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 15:51:08 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:51:08 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 15:51:08 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:51:08 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 15:51:08 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:51:08 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:51:08 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:51:08 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:51:08 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:51: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')]} 15:51:08 INFO - https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:51:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:51:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:51:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:51:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:51:18 INFO - Downloaded 24235306 bytes. 15:51:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:51:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:51:19 INFO - Return code: 0 15:51:19 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:51:19 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')]} 15:51:19 INFO - https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:51:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:51:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:51:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:51:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:51:21 INFO - Downloaded 24235306 bytes. 15:51:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:51:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:51:23 INFO - Return code: 0 15:51:23 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')]} 15:51:23 INFO - https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:51:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:51:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:51:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:51:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:51:24 INFO - Downloaded 10840145 bytes. 15:51:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:51:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:51:25 INFO - Return code: 0 15:51:25 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')]} 15:51:25 INFO - https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:51:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:51:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:51:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:51:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:51:28 INFO - Downloaded 56000752 bytes. 15:51:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:51:28 INFO - mkdir: /builds/slave/test/properties 15:51:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:51:28 INFO - Writing to file /builds/slave/test/properties/build_url 15:51:28 INFO - Contents: 15:51:28 INFO - build_url:https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:51:29 INFO - Running post-action listener: _resource_record_post_action 15:51:29 INFO - Running post-action listener: set_extra_try_arguments 15:51:29 INFO - ##### 15:51:29 INFO - ##### Running populate-webroot step. 15:51:29 INFO - ##### 15:51:29 INFO - Running pre-action listener: _resource_record_pre_action 15:51:29 INFO - Running main action method: populate_webroot 15:51:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:51:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:51:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:51:29 INFO - '--tppagecycles', 15:51:29 INFO - '7'], 15:51:29 INFO - 'tests': ['tsvgm']}}, 15:51:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:51:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:51:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:51:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:51:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:51:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:51:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:29 INFO - 'talos_options': ['--disable-e10s'], 15:51:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:29 INFO - 'talos_options': ['--disable-e10s'], 15:51:29 INFO - 'tests': ['damp', 'tps']}, 15:51:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:29 INFO - 'tests': ['damp', 'tps']}, 15:51:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:51:29 INFO - 'tests': ['dromaeo_dom']}, 15:51:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:51:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:51:29 INFO - 'tests': ['a11yr', 15:51:29 INFO - 'ts_paint', 15:51:29 INFO - 'tpaint', 15:51:29 INFO - 'sessionrestore', 15:51:29 INFO - 'sessionrestore_no_auto_restore', 15:51:29 INFO - 'tabpaint']}, 15:51:29 INFO - 'other-e10s': {'tests': ['a11yr', 15:51:29 INFO - 'ts_paint', 15:51:29 INFO - 'tpaint', 15:51:29 INFO - 'sessionrestore', 15:51:29 INFO - 'sessionrestore_no_auto_restore', 15:51:29 INFO - 'tabpaint']}, 15:51:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:51:29 INFO - 'ts_paint', 15:51:29 INFO - 'tpaint', 15:51:29 INFO - 'sessionrestore', 15:51:29 INFO - 'sessionrestore_no_auto_restore', 15:51:29 INFO - 'tabpaint']}, 15:51:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:51:29 INFO - 'ts_paint', 15:51:29 INFO - 'tpaint', 15:51:29 INFO - 'sessionrestore', 15:51:29 INFO - 'sessionrestore_no_auto_restore', 15:51:29 INFO - 'tabpaint']}, 15:51:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:51:29 INFO - 'tests': ['a11yr', 15:51:29 INFO - 'ts_paint', 15:51:29 INFO - 'tpaint', 15:51:29 INFO - 'sessionrestore', 15:51:29 INFO - 'sessionrestore_no_auto_restore', 15:51:29 INFO - 'tabpaint']}, 15:51:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:51:29 INFO - 'tests': ['a11yr', 15:51:29 INFO - 'ts_paint', 15:51:29 INFO - 'tpaint', 15:51:29 INFO - 'sessionrestore', 15:51:29 INFO - 'sessionrestore_no_auto_restore', 15:51:29 INFO - 'tabpaint']}, 15:51:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:51:29 INFO - 'tests': ['tsvgx', 15:51:29 INFO - 'tsvgr_opacity', 15:51:29 INFO - 'tart', 15:51:29 INFO - 'tscrollx', 15:51:29 INFO - 'cart']}, 15:51:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:51:29 INFO - 'tsvgr_opacity', 15:51:29 INFO - 'tart', 15:51:29 INFO - 'tscrollx', 15:51:29 INFO - 'cart']}, 15:51:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:29 INFO - 'talos_options': ['--disable-e10s'], 15:51:29 INFO - 'tests': ['tp5o']}, 15:51:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:29 INFO - 'tests': ['tp5o']}, 15:51:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:29 INFO - 'talos_options': ['--disable-e10s', 15:51:29 INFO - '--xperf_path', 15:51:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:29 INFO - 'tests': ['tp5n']}, 15:51:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:29 INFO - 'talos_options': ['--xperf_path', 15:51:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:29 INFO - 'tests': ['tp5n']}}, 15:51:29 INFO - 'talos.zip': {'path': '', 15:51:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:51:29 INFO - Running post-action listener: _resource_record_post_action 15:51:29 INFO - ##### 15:51:29 INFO - ##### Running create-virtualenv step. 15:51:29 INFO - ##### 15:51:29 INFO - Running pre-action listener: _resource_record_pre_action 15:51:29 INFO - Running main action method: create_virtualenv 15:51:29 INFO - Creating virtualenv /builds/slave/test/build/venv 15:51:29 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 15:51:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:51:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:51:29 INFO - Using real prefix '/usr' 15:51:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:51:30 INFO - Installing distribute.............................................................................................................................................................................................done. 15:51:32 INFO - Installing pip.................done. 15:51:32 INFO - Return code: 0 15:51:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:32 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 0x7f6b1b980f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf26410>, '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 0xf27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf277a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', '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 15:51:32 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 15:51:32 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 15:51:32 INFO - Using env: {'DISPLAY': ':0', 15:51:32 INFO - 'HOME': '/home/cltbld', 15:51:32 INFO - 'LANG': 'en_US.UTF-8', 15:51:32 INFO - 'LANGUAGE': 'en_US:en', 15:51:32 INFO - 'LOGNAME': 'cltbld', 15:51:32 INFO - 'MAIL': '/var/mail/cltbld', 15:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:32 INFO - 'MOZ_NO_REMOTE': '1', 15:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:32 INFO - 'NO_EM_RESTART': '1', 15:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:32 INFO - 'PWD': '/builds/slave/test', 15:51:32 INFO - 'SHELL': '/bin/bash', 15:51:32 INFO - 'SHLVL': '1', 15:51:32 INFO - 'TERM': 'linux', 15:51:32 INFO - 'TMOUT': '86400', 15:51:32 INFO - 'USER': 'cltbld', 15:51:32 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', 15:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:32 INFO - '_': '/tools/buildbot/bin/python'} 15:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:32 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 15:51:32 INFO - Cleaning up... 15:51:32 INFO - Return code: 0 15:51:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:32 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 0x7f6b1b980f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf26410>, '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 0xf27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf277a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', '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 15:51:32 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 15:51:32 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 15:51:32 INFO - Using env: {'DISPLAY': ':0', 15:51:32 INFO - 'HOME': '/home/cltbld', 15:51:32 INFO - 'LANG': 'en_US.UTF-8', 15:51:32 INFO - 'LANGUAGE': 'en_US:en', 15:51:32 INFO - 'LOGNAME': 'cltbld', 15:51:32 INFO - 'MAIL': '/var/mail/cltbld', 15:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:32 INFO - 'MOZ_NO_REMOTE': '1', 15:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:32 INFO - 'NO_EM_RESTART': '1', 15:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:32 INFO - 'PWD': '/builds/slave/test', 15:51:32 INFO - 'SHELL': '/bin/bash', 15:51:32 INFO - 'SHLVL': '1', 15:51:32 INFO - 'TERM': 'linux', 15:51:32 INFO - 'TMOUT': '86400', 15:51:32 INFO - 'USER': 'cltbld', 15:51:32 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', 15:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:32 INFO - '_': '/tools/buildbot/bin/python'} 15:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:32 INFO - Downloading/unpacking psutil>=0.7.1 15:51:32 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 15:51:32 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 15:51:32 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 15:51:32 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 15:51:32 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 15:51:32 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 15:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:51:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:35 INFO - Installing collected packages: psutil 15:51:35 INFO - Running setup.py install for psutil 15:51:35 INFO - building 'psutil._psutil_linux' extension 15:51:35 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 15:51:35 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 15:51:35 INFO - building 'psutil._psutil_posix' extension 15:51:35 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 15:51:35 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 15:51:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:35 INFO - Successfully installed psutil 15:51:35 INFO - Cleaning up... 15:51:35 INFO - Return code: 0 15:51:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:35 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 0x7f6b1b980f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf26410>, '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 0xf27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf277a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', '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 15:51:35 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 15:51:35 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 15:51:35 INFO - Using env: {'DISPLAY': ':0', 15:51:35 INFO - 'HOME': '/home/cltbld', 15:51:35 INFO - 'LANG': 'en_US.UTF-8', 15:51:35 INFO - 'LANGUAGE': 'en_US:en', 15:51:35 INFO - 'LOGNAME': 'cltbld', 15:51:35 INFO - 'MAIL': '/var/mail/cltbld', 15:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:35 INFO - 'MOZ_NO_REMOTE': '1', 15:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:35 INFO - 'NO_EM_RESTART': '1', 15:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:35 INFO - 'PWD': '/builds/slave/test', 15:51:35 INFO - 'SHELL': '/bin/bash', 15:51:35 INFO - 'SHLVL': '1', 15:51:35 INFO - 'TERM': 'linux', 15:51:35 INFO - 'TMOUT': '86400', 15:51:35 INFO - 'USER': 'cltbld', 15:51:35 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', 15:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:35 INFO - '_': '/tools/buildbot/bin/python'} 15:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:51:36 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 15:51:36 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 15:51:36 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 15:51:36 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 15:51:36 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 15:51:36 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 15:51:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:51:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:51:38 INFO - Installing collected packages: mozsystemmonitor 15:51:38 INFO - Running setup.py install for mozsystemmonitor 15:51:38 INFO - Successfully installed mozsystemmonitor 15:51:38 INFO - Cleaning up... 15:51:38 INFO - Return code: 0 15:51:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:38 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 0x7f6b1b980f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf26410>, '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 0xf27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf277a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', '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 15:51:38 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 15:51:38 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 15:51:38 INFO - Using env: {'DISPLAY': ':0', 15:51:38 INFO - 'HOME': '/home/cltbld', 15:51:38 INFO - 'LANG': 'en_US.UTF-8', 15:51:38 INFO - 'LANGUAGE': 'en_US:en', 15:51:38 INFO - 'LOGNAME': 'cltbld', 15:51:38 INFO - 'MAIL': '/var/mail/cltbld', 15:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:38 INFO - 'MOZ_NO_REMOTE': '1', 15:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:38 INFO - 'NO_EM_RESTART': '1', 15:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:38 INFO - 'PWD': '/builds/slave/test', 15:51:38 INFO - 'SHELL': '/bin/bash', 15:51:38 INFO - 'SHLVL': '1', 15:51:38 INFO - 'TERM': 'linux', 15:51:38 INFO - 'TMOUT': '86400', 15:51:38 INFO - 'USER': 'cltbld', 15:51:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', 15:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:38 INFO - '_': '/tools/buildbot/bin/python'} 15:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:38 INFO - Downloading/unpacking blobuploader==1.2.4 15:51:38 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 15:51:38 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 15:51:38 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 15:51:38 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 15:51:38 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 15:51:38 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 15:51:40 INFO - Downloading blobuploader-1.2.4.tar.gz 15:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:51:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:51:40 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 15:51:40 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 15:51:40 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 15:51:40 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 15:51:40 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 15:51:40 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 15:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:51:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:51:40 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 15:51:40 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 15:51:40 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 15:51:40 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 15:51:40 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 15:51:40 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 15:51:41 INFO - Downloading docopt-0.6.1.tar.gz 15:51:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:51:41 INFO - Installing collected packages: blobuploader, requests, docopt 15:51:41 INFO - Running setup.py install for blobuploader 15:51:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:51:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:51:41 INFO - Running setup.py install for requests 15:51:41 INFO - Running setup.py install for docopt 15:51:41 INFO - Successfully installed blobuploader requests docopt 15:51:41 INFO - Cleaning up... 15:51:41 INFO - Return code: 0 15:51:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:41 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')]} 15:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:41 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')]} 15:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:41 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 0x7f6b1b980f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf26410>, '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 0xf27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf277a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', '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 15:51:41 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 15:51:41 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 15:51:41 INFO - Using env: {'DISPLAY': ':0', 15:51:41 INFO - 'HOME': '/home/cltbld', 15:51:41 INFO - 'LANG': 'en_US.UTF-8', 15:51:41 INFO - 'LANGUAGE': 'en_US:en', 15:51:41 INFO - 'LOGNAME': 'cltbld', 15:51:41 INFO - 'MAIL': '/var/mail/cltbld', 15:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:41 INFO - 'MOZ_NO_REMOTE': '1', 15:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:41 INFO - 'NO_EM_RESTART': '1', 15:51:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:41 INFO - 'PWD': '/builds/slave/test', 15:51:41 INFO - 'SHELL': '/bin/bash', 15:51:41 INFO - 'SHLVL': '1', 15:51:41 INFO - 'TERM': 'linux', 15:51:41 INFO - 'TMOUT': '86400', 15:51:41 INFO - 'USER': 'cltbld', 15:51:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', 15:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:41 INFO - '_': '/tools/buildbot/bin/python'} 15:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:42 INFO - Running setup.py (path:/tmp/pip-TKLYA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:42 INFO - Running setup.py (path:/tmp/pip-Ne_sPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:42 INFO - Running setup.py (path:/tmp/pip-wqpRUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:42 INFO - Running setup.py (path:/tmp/pip-gEQAH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:42 INFO - Running setup.py (path:/tmp/pip-Q8BMD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:42 INFO - Running setup.py (path:/tmp/pip-Qa1Bzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:42 INFO - Running setup.py (path:/tmp/pip-M5CrG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:42 INFO - Running setup.py (path:/tmp/pip-dxKR4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:42 INFO - Running setup.py (path:/tmp/pip-xC74rD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:42 INFO - Running setup.py (path:/tmp/pip-QKmvkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:42 INFO - Running setup.py (path:/tmp/pip-kg7lL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:42 INFO - Running setup.py (path:/tmp/pip-a5N_5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:42 INFO - Running setup.py (path:/tmp/pip-zvcDFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:43 INFO - Running setup.py (path:/tmp/pip-Oxi2c5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:43 INFO - Running setup.py (path:/tmp/pip-W6R53k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:43 INFO - Running setup.py (path:/tmp/pip-wew9_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:43 INFO - Running setup.py (path:/tmp/pip-7wdU2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:43 INFO - Running setup.py install for manifestparser 15:51:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:43 INFO - Running setup.py install for mozcrash 15:51:43 INFO - Running setup.py install for mozdebug 15:51:43 INFO - Running setup.py install for mozdevice 15:51:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:51:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:43 INFO - Running setup.py install for mozfile 15:51:43 INFO - Running setup.py install for mozhttpd 15:51:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:43 INFO - Running setup.py install for mozinfo 15:51:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:44 INFO - Running setup.py install for mozInstall 15:51:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:44 INFO - Running setup.py install for mozleak 15:51:44 INFO - Running setup.py install for mozlog 15:51:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:44 INFO - Running setup.py install for moznetwork 15:51:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:44 INFO - Running setup.py install for mozprocess 15:51:44 INFO - Running setup.py install for mozprofile 15:51:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:44 INFO - Running setup.py install for mozrunner 15:51:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:44 INFO - Running setup.py install for mozscreenshot 15:51:44 INFO - Running setup.py install for moztest 15:51:45 INFO - Running setup.py install for mozversion 15:51:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:45 INFO - Cleaning up... 15:51:45 INFO - Return code: 0 15:51:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:45 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 0x7f6b1b980f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf26410>, '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 0xf27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf277a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', '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 15:51:45 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 15:51:45 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 15:51:45 INFO - Using env: {'DISPLAY': ':0', 15:51:45 INFO - 'HOME': '/home/cltbld', 15:51:45 INFO - 'LANG': 'en_US.UTF-8', 15:51:45 INFO - 'LANGUAGE': 'en_US:en', 15:51:45 INFO - 'LOGNAME': 'cltbld', 15:51:45 INFO - 'MAIL': '/var/mail/cltbld', 15:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:45 INFO - 'MOZ_NO_REMOTE': '1', 15:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:45 INFO - 'NO_EM_RESTART': '1', 15:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:45 INFO - 'PWD': '/builds/slave/test', 15:51:45 INFO - 'SHELL': '/bin/bash', 15:51:45 INFO - 'SHLVL': '1', 15:51:45 INFO - 'TERM': 'linux', 15:51:45 INFO - 'TMOUT': '86400', 15:51:45 INFO - 'USER': 'cltbld', 15:51:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', 15:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:45 INFO - '_': '/tools/buildbot/bin/python'} 15:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:45 INFO - Running setup.py (path:/tmp/pip-_PHeQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:45 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)) 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:45 INFO - Running setup.py (path:/tmp/pip-vz2tWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:45 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)) 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:45 INFO - Running setup.py (path:/tmp/pip-ZiWH9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:45 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)) 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:45 INFO - Running setup.py (path:/tmp/pip-iegEst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:45 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)) 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:45 INFO - Running setup.py (path:/tmp/pip-n0vLIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:45 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)) 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:45 INFO - Running setup.py (path:/tmp/pip-MKAlbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:45 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)) 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:45 INFO - Running setup.py (path:/tmp/pip-pt6lbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:45 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)) 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:45 INFO - Running setup.py (path:/tmp/pip-P_h3Z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:45 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)) 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:45 INFO - Running setup.py (path:/tmp/pip-M3uBB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:46 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)) 15:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:46 INFO - Running setup.py (path:/tmp/pip-N8ex87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:46 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)) 15:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:46 INFO - Running setup.py (path:/tmp/pip-9Bd5tX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:46 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)) 15:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:46 INFO - Running setup.py (path:/tmp/pip-XYCChX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:46 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)) 15:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:46 INFO - Running setup.py (path:/tmp/pip-haNf61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:46 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)) 15:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:46 INFO - Running setup.py (path:/tmp/pip-xuFQ7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:46 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)) 15:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:46 INFO - Running setup.py (path:/tmp/pip-EXiIDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:46 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)) 15:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:46 INFO - Running setup.py (path:/tmp/pip-9sdeO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:46 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)) 15:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:46 INFO - Running setup.py (path:/tmp/pip-3rfqPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:46 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)) 15:51:46 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)) 15:51:46 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)) 15:51:46 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)) 15:51:46 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)) 15:51:46 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)) 15:51:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:46 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 15:51:46 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 15:51:46 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 15:51:46 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 15:51:46 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 15:51:46 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 15:51:48 INFO - Downloading blessings-1.6.tar.gz 15:51:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:48 INFO - Installing collected packages: blessings 15:51:48 INFO - Running setup.py install for blessings 15:51:48 INFO - Successfully installed blessings 15:51:48 INFO - Cleaning up... 15:51:48 INFO - Return code: 0 15:51:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:51:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:49 INFO - Reading from file tmpfile_stdout 15:51:49 INFO - Current package versions: 15:51:49 INFO - argparse == 1.2.1 15:51:49 INFO - blessings == 1.6 15:51:49 INFO - blobuploader == 1.2.4 15:51:49 INFO - docopt == 0.6.1 15:51:49 INFO - manifestparser == 1.1 15:51:49 INFO - mozInstall == 1.12 15:51:49 INFO - mozcrash == 0.17 15:51:49 INFO - mozdebug == 0.1 15:51:49 INFO - mozdevice == 0.48 15:51:49 INFO - mozfile == 1.2 15:51:49 INFO - mozhttpd == 0.7 15:51:49 INFO - mozinfo == 0.9 15:51:49 INFO - mozleak == 0.1 15:51:49 INFO - mozlog == 3.1 15:51:49 INFO - moznetwork == 0.27 15:51:49 INFO - mozprocess == 0.22 15:51:49 INFO - mozprofile == 0.28 15:51:49 INFO - mozrunner == 6.11 15:51:49 INFO - mozscreenshot == 0.1 15:51:49 INFO - mozsystemmonitor == 0.0 15:51:49 INFO - moztest == 0.7 15:51:49 INFO - mozversion == 1.4 15:51:49 INFO - psutil == 3.1.1 15:51:49 INFO - requests == 1.2.3 15:51:49 INFO - wsgiref == 0.1.2 15:51:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:49 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 0x7f6b1b980f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf26410>, '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 0xf27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf277a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', '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 15:51:49 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 15:51:49 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 15:51:49 INFO - Using env: {'DISPLAY': ':0', 15:51:49 INFO - 'HOME': '/home/cltbld', 15:51:49 INFO - 'LANG': 'en_US.UTF-8', 15:51:49 INFO - 'LANGUAGE': 'en_US:en', 15:51:49 INFO - 'LOGNAME': 'cltbld', 15:51:49 INFO - 'MAIL': '/var/mail/cltbld', 15:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:49 INFO - 'MOZ_NO_REMOTE': '1', 15:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:49 INFO - 'NO_EM_RESTART': '1', 15:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:49 INFO - 'PWD': '/builds/slave/test', 15:51:49 INFO - 'SHELL': '/bin/bash', 15:51:49 INFO - 'SHLVL': '1', 15:51:49 INFO - 'TERM': 'linux', 15:51:49 INFO - 'TMOUT': '86400', 15:51:49 INFO - 'USER': 'cltbld', 15:51:49 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', 15:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:49 INFO - '_': '/tools/buildbot/bin/python'} 15:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:49 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)) 15:51:49 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)) 15:51:49 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)) 15:51:49 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)) 15:51:49 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)) 15:51:49 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)) 15:51:49 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)) 15:51:49 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)) 15:51:49 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)) 15:51:49 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)) 15:51:49 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)) 15:51:49 INFO - Cleaning up... 15:51:49 INFO - Return code: 0 15:51:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:49 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 0x7f6b1b980f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf26410>, '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 0xf27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf277a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', '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 15:51:49 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 15:51:49 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 15:51:49 INFO - Using env: {'DISPLAY': ':0', 15:51:49 INFO - 'HOME': '/home/cltbld', 15:51:49 INFO - 'LANG': 'en_US.UTF-8', 15:51:49 INFO - 'LANGUAGE': 'en_US:en', 15:51:49 INFO - 'LOGNAME': 'cltbld', 15:51:49 INFO - 'MAIL': '/var/mail/cltbld', 15:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:49 INFO - 'MOZ_NO_REMOTE': '1', 15:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:49 INFO - 'NO_EM_RESTART': '1', 15:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:49 INFO - 'PWD': '/builds/slave/test', 15:51:49 INFO - 'SHELL': '/bin/bash', 15:51:49 INFO - 'SHLVL': '1', 15:51:49 INFO - 'TERM': 'linux', 15:51:49 INFO - 'TMOUT': '86400', 15:51:49 INFO - 'USER': 'cltbld', 15:51:49 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', 15:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:49 INFO - '_': '/tools/buildbot/bin/python'} 15:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:49 INFO - Downloading/unpacking jsonschema 15:51:49 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 15:51:49 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 15:51:49 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 15:51:49 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 15:51:49 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 15:51:49 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 15:51:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:51:51 INFO - Downloading/unpacking functools32 (from jsonschema) 15:51:51 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 15:51:51 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 15:51:51 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 15:51:51 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 15:51:51 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 15:51:51 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 15:51:51 INFO - Downloading functools32-3.2.3-2.tar.gz 15:51:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:51:51 INFO - warning: no files found matching '*.txt' 15:51:51 INFO - no previously-included directories found matching 'build' 15:51:51 INFO - no previously-included directories found matching 'dist' 15:51:51 INFO - no previously-included directories found matching '.git*' 15:51:51 INFO - Installing collected packages: jsonschema, functools32 15:51:51 INFO - Running setup.py install for functools32 15:51:51 INFO - warning: no files found matching '*.txt' 15:51:51 INFO - no previously-included directories found matching 'build' 15:51:51 INFO - no previously-included directories found matching 'dist' 15:51:51 INFO - no previously-included directories found matching '.git*' 15:51:51 INFO - Successfully installed jsonschema functools32 15:51:51 INFO - Cleaning up... 15:51:52 INFO - Return code: 0 15:51:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:52 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 0x7f6b1b980f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe975a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf26410>, '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 0xf27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf277a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', '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 15:51:52 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 15:51:52 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 15:51:52 INFO - Using env: {'DISPLAY': ':0', 15:51:52 INFO - 'HOME': '/home/cltbld', 15:51:52 INFO - 'LANG': 'en_US.UTF-8', 15:51:52 INFO - 'LANGUAGE': 'en_US:en', 15:51:52 INFO - 'LOGNAME': 'cltbld', 15:51:52 INFO - 'MAIL': '/var/mail/cltbld', 15:51:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:52 INFO - 'MOZ_NO_REMOTE': '1', 15:51:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:52 INFO - 'NO_EM_RESTART': '1', 15:51:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:52 INFO - 'PWD': '/builds/slave/test', 15:51:52 INFO - 'SHELL': '/bin/bash', 15:51:52 INFO - 'SHLVL': '1', 15:51:52 INFO - 'TERM': 'linux', 15:51:52 INFO - 'TMOUT': '86400', 15:51:52 INFO - 'USER': 'cltbld', 15:51:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', 15:51:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:52 INFO - '_': '/tools/buildbot/bin/python'} 15:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:52 INFO - Downloading/unpacking flake8 15:51:52 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 15:51:52 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 15:51:52 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 15:51:52 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 15:51:52 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 15:51:52 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 15:51:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:51:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:51:54 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 15:51:54 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 15:51:54 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 15:51:54 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 15:51:54 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 15:51:54 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 15:51:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:51:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:51:54 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 15:51:54 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 15:51:54 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 15:51:54 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 15:51:54 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 15:51:54 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 15:51:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:51:54 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 15:51:54 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 15:51:54 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 15:51:54 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 15:51:54 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 15:51:54 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 15:51:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:51:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:54 INFO - no previously-included directories found matching 'docs/_build' 15:51:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:51:54 INFO - Running setup.py install for pep8 15:51:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:54 INFO - no previously-included directories found matching 'docs/_build' 15:51:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:51:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:51:55 INFO - Cleaning up... 15:51:55 INFO - Return code: 0 15:51:55 INFO - Running post-action listener: _resource_record_post_action 15:51:55 INFO - Running post-action listener: _start_resource_monitoring 15:51:55 INFO - Starting resource monitoring. 15:51:55 INFO - ##### 15:51:55 INFO - ##### Running install step. 15:51:55 INFO - ##### 15:51:55 INFO - Running pre-action listener: _resource_record_pre_action 15:51:55 INFO - Running main action method: install 15:51:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:55 INFO - Reading from file tmpfile_stdout 15:51:55 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:51:55 INFO - Reading from file tmpfile_stdout 15:51:55 INFO - Output received: 15:51:55 INFO - Usage: mozinstall [options] installer 15:51:55 INFO - Options: 15:51:55 INFO - -h, --help show this help message and exit 15:51:55 INFO - -d DEST, --destination=DEST 15:51:55 INFO - Directory to install application into. [default: 15:51:55 INFO - "/builds/slave/test"] 15:51:55 INFO - --app=APP Application being installed. [default: firefox] 15:51:55 INFO - mkdir: /builds/slave/test/build/application 15:51:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:52:08 INFO - Reading from file tmpfile_stdout 15:52:08 INFO - Output received: 15:52:08 INFO - /builds/slave/test/build/application/firefox/firefox 15:52:08 INFO - Running post-action listener: _resource_record_post_action 15:52:08 INFO - ##### 15:52:08 INFO - ##### Running run-tests step. 15:52:08 INFO - ##### 15:52:08 INFO - Running pre-action listener: _resource_record_pre_action 15:52:08 INFO - Running main action method: run_tests 15:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:52:08 INFO - Python 2.7.3 15:52:08 INFO - Return code: 0 15:52:08 INFO - grabbing minidump binary from tooltool 15:52: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')]} 15:52:08 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 0xf26410>, '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 0xf27310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf277a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:52:08 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 15:52:08 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 15:52:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:52:08 INFO - Return code: 0 15:52:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:52:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:52:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:52:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:52:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:52:09 INFO - Return code: 0 15:52:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 15:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 15:52:09 INFO - Using env: {'DISPLAY': ':0', 15:52:09 INFO - 'HOME': '/home/cltbld', 15:52:09 INFO - 'LANG': 'en_US.UTF-8', 15:52:09 INFO - 'LANGUAGE': 'en_US:en', 15:52:09 INFO - 'LOGNAME': 'cltbld', 15:52:09 INFO - 'MAIL': '/var/mail/cltbld', 15:52:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:52:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:09 INFO - 'MOZ_NO_REMOTE': '1', 15:52:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:09 INFO - 'NO_EM_RESTART': '1', 15:52:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:09 INFO - 'PWD': '/builds/slave/test', 15:52:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:52:09 INFO - 'SHELL': '/bin/bash', 15:52:09 INFO - 'SHLVL': '1', 15:52:09 INFO - 'TERM': 'linux', 15:52:09 INFO - 'TMOUT': '86400', 15:52:09 INFO - 'USER': 'cltbld', 15:52:09 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801', 15:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:09 INFO - '_': '/tools/buildbot/bin/python'} 15:52:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 15:52:09 INFO - mozversion application_buildid: 20160629130426 15:52:09 INFO - mozversion application_changeset: ee43fafecf41bc2048b100e1fe2e272144884d19 15:52:09 INFO - mozversion application_display_name: Firefox 15:52:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:52:09 INFO - mozversion application_name: Firefox 15:52:09 INFO - mozversion application_remotingname: firefox 15:52:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:52:09 INFO - mozversion application_vendor: Mozilla 15:52:09 INFO - mozversion application_version: 48.0 15:52:09 INFO - mozversion platform_buildid: 20160629130426 15:52:09 INFO - mozversion platform_changeset: ee43fafecf41bc2048b100e1fe2e272144884d19 15:52:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:52:09 INFO - mozversion platform_version: 48.0 15:52:09 INFO - using testdate: 1467240729 15:52:09 INFO - actual date: 1467240729 15:52:09 INFO - starting webserver on 'localhost:59975' 15:52:09 INFO - SUITE-START | Running 2 tests 15:52:09 INFO - TEST-START | dromaeo_css 15:52:09 INFO - operating with platform_type : linux_ 15:52:09 INFO - Initialising browser for dromaeo_css test... 15:52:09 INFO - TEST-INFO | started process 27210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCCotxq/profile http://localhost:59975/getInfo.html) 15:52:14 INFO - PROCESS | 27210 | __metrics Screen width/height:1600/1200 15:52:14 INFO - PROCESS | 27210 | colorDepth:24 15:52:14 INFO - PROCESS | 27210 | Browser inner width/height: 1024/697 15:52:14 INFO - PROCESS | 27210 | __metrics 15:52:16 ERROR - PROCESS | 27210 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:52:17 INFO - TEST-INFO | 27210: exit 0 15:52:17 INFO - Browser initialized. 15:52:17 INFO - Running cycle 1/1 for dromaeo_css test... 15:52:17 INFO - TEST-INFO | started process 27302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCCotxq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:29 INFO - PROCESS | 27302 | RSS: Main: 139423744 15:52:29 INFO - PROCESS | 27302 | 15:53:20 INFO - PROCESS | 27302 | 1467240800042 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] 15:55:27 INFO - PROCESS | 27302 | Cycle 1(1): loaded http://localhost:59975/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59975/tests/dromaeo/cssquery-ext.html) 15:55:28 INFO - PROCESS | 27302 | RSS: Main: 248553472 15:55:28 INFO - PROCESS | 27302 | 15:58:30 INFO - PROCESS | 27302 | Cycle 1(1): loaded http://localhost:59975/tests/dromaeo/cssquery-ext.html (next: http://localhost:59975/tests/dromaeo/cssquery-jquery.html) 15:58:31 INFO - PROCESS | 27302 | RSS: Main: 223346688 15:58:31 INFO - PROCESS | 27302 | 16:01:32 INFO - PROCESS | 27302 | Cycle 1(1): loaded http://localhost:59975/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59975/tests/dromaeo/cssquery-mootools.html) 16:01:33 INFO - PROCESS | 27302 | RSS: Main: 218722304 16:01:33 INFO - PROCESS | 27302 | 16:04:35 INFO - PROCESS | 27302 | Cycle 1(1): loaded http://localhost:59975/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59975/tests/dromaeo/cssquery-prototype.html) 16:04:35 INFO - PROCESS | 27302 | RSS: Main: 215760896 16:04:35 INFO - PROCESS | 27302 | 16:07:38 INFO - PROCESS | 27302 | Cycle 1(1): loaded http://localhost:59975/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59975/tests/dromaeo/cssquery-yui.html) 16:07:38 INFO - PROCESS | 27302 | RSS: Main: 209620992 16:07:38 INFO - PROCESS | 27302 | 16:10:41 INFO - PROCESS | 27302 | Cycle 1(1): loaded http://localhost:59975/tests/dromaeo/cssquery-yui.html (next: http://localhost:59975/tests/dromaeo/cssquery-dojo.html) 16:10:41 INFO - PROCESS | 27302 | RSS: Main: 253587456 16:10:41 INFO - PROCESS | 27302 | 16:10:41 INFO - PROCESS | 27302 | __start_tp_report 16:10:41 INFO - PROCESS | 27302 | _x_x_mozilla_page_load 16:10:41 INFO - PROCESS | 27302 | _x_x_mozilla_page_load_details 16:10:41 INFO - PROCESS | 27302 | |i|pagename|runs| 16:10:41 INFO - PROCESS | 27302 | |0;dojo.html;3244.1565193049805;3265.1184180271325;3270.9509357359634;3298.175456135966;3312.734981201504;5328.573714102872;5330.1205301125365;5347.197920311955;5358.249845021695;5360.839174824751;5355.223492593581;5355.758990845412;5362.2224777407255;5365.651232669874;5371.650842695222;4829.492903245161;4837.975810120954;4918.508149185071;4992.32603598515;5001.524855138774;4845.055214233226;4867.902641947159;4912.48418916014;4953.752312384385;4955.554000139987;4903.9754801225945;4911.5088491150955;4952.702837829742;4960.305557221992;4983.6760610560195;4989.525995030484;4990.925136122924;5005;5015.448300686921;5036.848894533152;4797.808087676489;4876.60987121033;4889.33993910821;4906.975465122688;4946.035523073002;5303.867403314909;5337.226102215157;5352.598555108382;5360.115580929142;5365.892682146375;5721.456461636138;5800.941990580124;5803.9709801451145;5805.042168042311;5806.796762113306;5795.884082318372;5817.825465236049;5856.76572937082;5876.206712093898;5924.170616113747;5393.7572809223675;5398.838034858961;5411.621186516984;5442;5446.455354464521;5874.500667443315;5955.702214889325;5980.252468441445;5982.282126144891;5984.461398474158;5512.39363669996;5583.748731307101;5605.215269862222;5625.38120806711;5657.179708942181;5708.9723849706625;5714.028615135437;5716.7994721109035;5717.056685646821;5727.455891690282;5599.216109744639;5688.288963879515;5690.5163061140265;5692.658440493584;5727.140928860705;5775.451332123442;5797.565182611321;5801.071828507418;5807.622504537191;5836.67898265591;4404.515503294635;4405.207062728739;4406.647468202536;4407.096545208225;4429.82280708768;3879.553851307136;3923.2938071146896;3956.40653901917;3970.285348637215;4016.9196616067516;5445.782168713207;5455.1271796512365;5474.890502190014;5480.314960629921;5494.423085576037;5663.1505274208375;5727.198192253088;5728.283964504437;5730.598858079978;5733.111367738007;5384.380796208407;5419.701916394557;5442.2108794225405;5529.087700529368;5529.502344788988;4821.734804585712;4833.202521583969;4859.878503037452;4862.5380588844;4882.340883980688;5856.531477481792;5899.351071382144;5902.61632993854;5907.054871220584;5908.468237858528;5663.858403539944;5711.600187986801;5749.8562535936935;5770.422957704196;5786.537077033911;5940.910886336795;5963.075723262901;5999.610025348338;6027.427394397525;6029.758809647565;5570.888582228252;5678.346990096192;5681.545476361964;5694.971525142348;5695;5771.3651498335985;5820.097884827858;5824.039033559416;5827.329857066492;5865.3254875688135;5582.8325150245555;5608.38307786135;5627.690477023803;5628.465295796893;5633.718314084362;5498.835034948958;5553.08374118266;5556.277683901067;5563.7496312666835;5616.803411880564;5581.609287349846;5601.7759289629585;5604.579656525695;5608.747606357642;5643.52030077448;5667.404922483245;5681.886362272814;5684.403137670651;5697.7151142443545;5699.487046165865;5475.123980163155;5560.610757246954;5576.442355764391;5623.268975033219;5632.352279487911 16:10:41 INFO - PROCESS | 27302 | |1;ext.html;664.2195420381051;680.3774546290144;681.4003676764446;735.0407717928105;750.0811505905267;31047;31517;31613.051608451755;37787.81106094466;39188.21623567527;43828.12343753123;44144.33783493242;44398;44464;44712;8762.123787621234;8936.195742383185;8939.687110951118;8941.150590693873;8948.06045365237;8877.73366798997;9066.954665226665;9070.954645226764;9072.818543629124;9075.047120052399;9050.86423703645;9079;9109.362344635878;9115;9119.361644684876;9043.050479699636;9050.366474346798;9089.727308180733;9090.545472726337;9096.135867092615;9059.18467337936;9149.451032938045;9165.312601554844;9167.908320916838;9169.77075573116;40141.79929100365;40429.595704043175;40504;40535.18929621391;40577.59422405768;3578.3380074686265;3710.5176327077306;3750.8124593770476;4371.388005679208;4737.028909073631;28923.855380723173;31062.223444413845;31920;31991.200219994455;32967.6703232967;4243.915121697549;4380.824767009348;4614.123316569875;4614.9077018459775;4793.161196790583;220231.9999999984;220329;222033;222183;222801;40277;58775;59216.70391648014;59234.40765592375;59319.703401482715;38302;38310.6168938307;38407.80796096002;38444.807775960944;38456.615433845305;17273.481795546155;17415.129243537773;17474.47576572705;17492.387766428114;17492.47522574325;14229.50196743109;14309.856901430852;14360.281985900663;14374.928125359516;14386.208758518382;9320.347575669774;9356.111169438893;9396.718098457057;9506.382085164441;9560.856587151198;3564.7326450515798;3592.2038980509747;3624.5469316335457;3652.8904132876055;3724.9627503724614;1107.44074242507;1120.4173829608558;1151.844500992372;1187.4122309456702;1197.5628895453272;33631.83184084064;34781.13047173841;35507;35687.10782230465;36181.09547261339;1192.7793358228755;1210.9697257568632;1248.7252804383022;1306.45129045801;1309.9782169907487;13838.980043681031;17724.645507089786;18506.629867402575;18616.906915465337;18735.437936861916;452783;465534;467363;469962;470078;60663.69668151719;61602.38397616056;61756.69121654363;61784.38215617876;61809.69095154495;1341.8792308692264;1481.4222453243244;1518.3471107423693;1535.332130523226;1537.5848520899517;30526.236844078187;34907.30185396227;36006.45990310095;36110.819445902605;36187;61415.078773819325;62430.687846560475;62440.68779656073;62440.68779656073;62487;422395;428140;428925;428993;431081;40571.39142912918;49530.504694952586;51099.48900511096;51327.743361282955;51714.741426292625;48882;50936.98126037532;55299;55467.44532554623;56746.71626642006;40520.189596208504;40758;40795.59204407918;42033;45374.54625453703;42388.78805605952;43519;43695.56304436915;44398.55601443944;45323.32015019843;45038;45255.321170181815;45897;46733.532664672915;47168;39229.80385098056;40178.59821401865;40786;40807.59192408038;41354.172916542106;30556.388872222877;30813.383732325678;31027;31164.68835311618;31256.21859453532 16:10:41 INFO - PROCESS | 27302 | |2;jquery.html;422.4698004004973;424.2490791299402;428.8842012656581;429.6240789309354;434.4504202184236;18725.719114213298;19503.609927801437;19533.316333928316;19810.40568782939;20622;19137.808621913777;19352.612947741036;19365;19366.612667746638;19393.4181974541;5221.895562088756;5446.428125046872;5831.883362332751;6089.756409743605;6110.908336374936;3964.2071585682834;5643.68959707216;5926.644401335912;6003.459688628022;6066.241719785027;5902.911456328158;5924.674142922137;5925.762969481216;5935.228420305376;5941.88116237675;5707.200991861122;5854.560907931901;6076.3923607639545;6083.665398403086;6092.756289748405;3810.447485114643;3962.3660214365564;5567.387587365387;5843.3864444233595;5861.560382971252;13877.37551810171;14018.299085045706;14021.85978140226;14104.506342277971;14135.929320353333;2209.304069218191;2441.426264827764;2627.750363715444;2703.2701170684004;2751.477219328341;10310.639127630571;10313.381197128121;10833;13046.804297935538;14740.926295368561;2033.7864524224892;2097.5699981503753;2211.248175620297;2227.7994980451836;2326.4067662745892;85277.57361213217;85315;87432;89568;89614.99999999935;11128.554857805597;11285.661430157108;11359.432028398713;11616.94191529037;12202.755944881053;15309.6172595686;15459;15598.376064957502;15609;15624.203216630005;9047.140521650434;9071.727848164566;9104.681336153202;9172.174504294646;9179.954100229455;9313.90686093144;9346.813063738688;9358.344915855962;9397.436153830791;9407.529623518796;5018.347614810052;5034.496550344937;5091.949080509222;5093.796248150106;5114.028334616411;1854.7665802241359;2004.829589484881;2034.2371610646007;2057.6193404220267;2097.947551311199;1005.6580762540772;1047.5024363427463;1126.5437497813234;1128.311729844794;1129.836173754801;19140.904295478435;19353.903230483756;19368.515787105152;19543.0228488575;19739.506512337306;1011.630754774502;1054.920880933933;1057.4289883462998;1074.9623763168252;1147.6671765188003;10538.104261137889;10938.781224375469;10969.396683182342;10986.285891417032;11018.11855051594;563117;572142;588751;598783;605669;98827.50586247022;98976.50511747395;99635;99644.5017774921;100818;1132.0830127596673;1151.5451396698425;1153.6366044695894;1157.028096399012;1194.116353898109;17088.658226835643;17230.483085507454;17318.65362692714;17331.913340433217;17453.912730436266;38244.42633360446;38357;39586.604133958295;39935.20129597334;40678.38982415207;54179.72910135582;54861;56505.43494565002;57132.42867571271;57407.712961434925;8872.157145071207;9081.68214112503;9241.168294853227;9262.675806346746;9352.53237338144;10767.730806729895;12700.936495317465;13561.660958476117;13937.163770173416;14199.787003194753;11894.821577676516;11897.762044759229;12059.336736479227;12197.939010304892;12373;11548.249363791327;11678.06575473977;11683.415829208676;12008.63974080779;12165.08761842883;12060.638180854588;12078.094142939139;12105.576304829288;12186;12456.12807103494;8861.33539984491;8929.910700892908;8957.507337096522;9146.405483643808;9204.95397523008;12131;12152.878471215528;12284.508619655113;12414.875851241371;12585.622431327074 16:10:41 INFO - PROCESS | 27302 | |3;mootools.html;1448.4568286892415;1566.5378713279579;1577.2350410051126;1794.9012804295767;1945.124693887751;8049.07435644901;8200.302974247188;8264.173582641733;8284.378671599632;8296.377771667134;8150.9592452037805;8300.584970751468;8300.792480187998;8300.958495207531;8304.584770761452;2468.6790717206736;2489.141246270043;2490.8256422050463;2493.551160791057;2493.7880280176205;2451.9264422067367;2493.6758221431187;2500.5624015797252;2515.270571534262;2518.647389365481;2433.4768024874647;2455.9263222103364;2457.1522824625563;2457.373369790701;2457.7588317899526;2409.891554880026;2415.9637605435846;2432.1122790181544;2475.6410320503605;2485.726570077308;2425.260295609838;2453.815963802722;2458.0167932826835;2467.481828815951;2515.195137555983;7928.603569821544;8006.599670016476;8343.415960882741;8376.078631350547;8400.453970491959;5201.063808514466;5299.390570084451;5301.231321458367;5301.920471192935;5307.416184219733;3513.7013353864954;3557.1818481749083;3568.7323450741037;3577.8032208228537;3610.1696609779897;1191.6365508519898;1213.3690480949856;1215.4773447417606;1233.5250928392634;1264.740728150727;11372.14708896836;11399.48702308398;11468.655940321803;11474.024707899838;11530.42347882611;4471.463424389094;4604.861854144381;4616.8614941551805;4638.698484598491;4651.162790697707;9215.861762073575;9219.354645174773;9232.953835230916;9239.168474837297;9244.445333280024;5331.1470164773455;5333.733313334318;5335.919961200585;5338.91991620126;5339.385970613429;4281.2293787118;4786.377770889762;4934.136526107916;4963.057019166346;4963.106640804617;3827.4641550182996;3863.8068096595057;3915.8433662653174;3916.2167566486814;3961.3859851723028;1194.5878671858368;1212.781699294118;1214.969625759363;1216.3796463803346;1229.7786398448186;944.2964991081689;1038.8078205532001;1050.1861057680205;1053.2679787547734;1056.8890266521905;5755.3381361143165;5874.206982057368;5884.5273895277805;5917.319508256605;6108.725107370179;952.4333021851987;1018.5212949913529;1046.6179844356755;1080.1143062688677;1097.4896673047072;3917.2361389529337;4042.0703238255364;4043.110515686544;4088.2436749200897;4089.5092588889524;9943.701688949342;10207.438590877424;10242.641507547349;10257.128144107684;10276.794464110826;9927.056929591678;10111.747206319753;10123.898761012442;10131.848022279672;10143.898561014443;7671.462997590115;7865.449418540762;7868.0951690555175;7877.527348359117;7878.212178782191;5425.593080519056;5553.194786755978;5563.443655634404;5677.460641239076;5755.683437410982;8443.197896199852;8456.450330728483;8570.057293697564;8813.823723525622;8995.775105622412;8623.65505379803;8802;8840.469571825712;8890.866637000321;8902.821943561223;6691.933080669131;7154;7261.891071634035;7269.236730143259;7336.119665640157;7863.292303692695;7886.684532618631;7951.125376208728;7953.443258971816;7962.601869906365;6817.89773153413;7165.176004759519;7184.820379490555;7188.640567971476;7321.890171647536;7128.643567821692;7204.639768011473;7218.27817218274;7233.204347521663;7317.926820731725;6795.218549866631;6851.657417129024;6851.9657401712675;6853.109095817512;6863.519553631398;4954.777035033504;5030.346055012825;5074.010567939216;5094.363204599425;5107.208382700687;4874.317595536557;4935.185694360391;4996.950030499648;5117.1300878851425;5198.246254293031 16:10:41 INFO - PROCESS | 27302 | |4;prototype.html;353.84430850425827;356.342547998942;359.2904014571221;359.41236079010815;361.22877656203997;6080.6351618902845;6081.148639190511;6138.140660307555;6141.539384546155;6153.630782153074;6064.302605200403;6071.757129714806;6078.908816367758;6091.969540152293;6099.115628233914;4441.977790111053;4569.200389931765;4657.5575320344515;4688.859334219962;4691.29630555416;4666.883327916796;4678.134545109166;4680.063987202556;4684.1334353144775;4707.764611769415;4439;4647.279671650883;4659.720416775004;4661.510541393156;4668.743219122947;4518.367428560005;4562.703424277428;4570.040291538781;4643.791029403685;4650.790714417825;4096.283150448659;4108.1783643271465;4114.177164567069;4116.464859568267;4118.114605359862;5842.24050873388;5846.21076154718;5861.091530812688;5861.531077513789;5862.97068514659;5392.703401312926;5394.649347792381;5401.918971215435;5414.648047876875;5414.700471886719;6367.4906007519285;6379.36206379363;6390.840228994312;6395.744170233185;6397.552171347961;4293.656507479394;4446.666500012479;4451.666125040602;4454.57681520255;4454.643628509712;6571.671416429207;6656.434203092695;6664.233613134503;6681.231658359254;6682.064510968468;4545.568171023748;4545.704529205591;4552.226121559343;4553.248713962159;4553.61294289989;4590.380298659705;4595.632349412039;4602.585767280961;4605.608523275492;4606.124836281096;5311.814086506954;5322.627416080837;5328.333958255218;5336.279602253724;5338.786448542092;6191.380861913863;6400.967995159995;6405.903911441332;6442.9355706443275;6462.224533056064;1577.345401658299;1579.2972127403195;1588.3884704388893;1590.7931968843977;1591.785109010292;995.0894931138073;1036.9637062702768;1045.639254457211;1048.533402635835;1055.7149569616315;6169.2288463942;6258.906116408258;6278.058291256257;6280.623162610258;6284;6613.206415230203;6620.668966551653;6697.497687673444;6705.530612857053;6712.060311556386;6274.435300822856;6329.841753956188;6332.810015699536;6341.429271365507;6343.397377249154;3545.1137215696076;3590.9281814363567;3591.838367273479;3592.407252803258;3593.3531964246163;6824.18109826824;6978.895316570255;6981.127359080115;7006.334398232159;7011.088558487466;6773.796786096425;6791.219009813836;6805.455563554904;6808.4212841908;6810.557313774688;6975.581465112109;6978.232394436608;6980.895286570705;6983.930160698328;6988.091548098816;6666.633335166613;6697.397234248941;6698.631575263407;6701.497387696039;6704.731810727516;6328.430441260309;6537.953927371597;6539.4768418525455;6594.802155935329;6594.8351291218105;6935.133108361455;6955.791326260221;6980.51136420466;6992;6996.370326670624;4528;4565.452145742533;4565.589096981287;4567.474740404896;4577.977110114428;6628.83427914306;6640.800775976729;6655.534112612264;6657;6664.666766661744;6345.555811093179;6461.64460954652;6465.0948867157695;6466.482681385572;6470.7088181032905;6437.903431448438;6462.159919210472;6464.547481676237;6467.514936379696;6468.450181734605;6357.523185760994;6361.809145725636;6372.0760489729655;6372.203474565679;6381.649009304533;6494.577852439766;6496.902546461902;6510.251321097945;6510.73957041713;6525.902111468236;5961.433663801932;6084.482818960438;6340.4293613575;6350.269718982377;6359.332270111571 16:10:41 INFO - PROCESS | 27302 | |5;yui.html;896.1934259166745;906.2613969614765;912.2792993535107;912.8083102548464;914.6204325205036;14543.345549450274;14731.926340368283;14737.557873263793;14805.03767255129;17020;16073;16165.43420980266;16188.595285117877;16193.83806161941;16235.025898446102;749.0935967479356;906.9682561110362;922.993936609096;923.2429407885537;930.0978051290238;896.3770179725094;901.1079031758545;904.6155383961823;904.674317245791;907.1835348186652;965.2133511188395;965.2663975378728;965.3676841668719;965.6378857928277;966.618185816602;782.4249176855006;947.4315410753561;957.6360982826482;957.683964291782;967.4533888353093;688.8897776355809;693.143967200507;693.7398475571661;700.6951975890504;702.0241863809309;14999.475018374305;15052.623684407868;15068.698626027528;15078.849211507853;15083.245837708071;13935.233562154077;14168.645783855383;14249.78625320621;14257.215853128073;14514.491992780202;11739.941300293529;11881.40592970348;11917.165798394115;12077.57728479499;12233.69415764613;4671.159191345557;4746.311784791186;4746.430428348585;4756.619470442356;4833.854984350475;56216.43783562194;56808;56821.71589142028;56907.14639280414;56990.43009569934;11038.724031899106;11298.09615230796;11317.207795454404;11822.822657660143;12018.819717704242;20025.799742002684;20169;20182.798172018385;20212.89893550523;20238.797612023693;8577.4424662398;8862;8863.157999989991;8909.287257019423;8911;4933.777979990838;5013.423456302499;5029.64792464524;5097.108006098918;5202;3509.280597477511;3568.6966607838626;3570.946435803465;3576.1774791798034;3579.552555930509;610.4536439886366;612.9233845769279;613.4172536090732;615.3815415507387;615.8829822333743;631.2204427531994;697.5814511293285;748.8364692310661;770.9845803083907;775.6005657086492;9592.184664303473;9615.759606009766;9660.661876834418;9669.661561845302;9712.417254964725;742.7623160588668;768.5427170833345;774.0658252907696;787.2206515549565;807.8868958345719;4524.253498172765;4544.091181763661;4599.356090147382;4619.792109355087;4687.671862969628;63047.684761575896;63738.36261637417;64418;64425;70745.64627176832;55032.449675503536;55604;55638.44361556414;55891;57645;50636.493635063176;51078;51262.231066534034;51368;51876.22185667218;9549.379290346105;9743.415395076318;9798.951005244928;9859.112679858847;9926.255530835071;37566.624333756314;38237.61762382452;38361.616383835804;39973.60026399699;39976.200475990896;43741;44005.77997110122;47263.52736472729;49638.75180624074;50126.24810627916;12804.935975320064;12845.229286242855;12955.870441295467;13041.673958151123;13119.344032798132;13346.466141354236;13433.26117063571;14082.014259001771;14339.856601433852;15306.693866122838;13152.89340709235;13891.374888129856;14130.576082717535;14161.645958851112;14649.487267945571;12855.228686278853;13162;13749.587512374645;13910;14049.578512644637;11858.644240672793;12078.758424831278;12272.202306850026;12513.311767852856;12516.436760345989;11365;11458.94270528642;11745.823812642988;11781.823272651089;11977.401129943293;11513.357846800807;11582.36297003673;11620.825687614524;11770.882291176978;11849.289042657469 16:10:41 INFO - PROCESS | 27302 | __end_tp_report 16:10:41 INFO - PROCESS | 27302 | __start_cc_report 16:10:41 INFO - PROCESS | 27302 | _x_x_mozilla_cycle_collect,807 16:10:41 INFO - PROCESS | 27302 | __end_cc_report 16:10:41 INFO - PROCESS | 27302 | __startTimestamp1467241841496__endTimestamp 16:10:41 INFO - PROCESS | 27302 | 16:10:41 INFO - PROCESS | 27302 | ------- Summary: start ------- 16:10:41 INFO - PROCESS | 27302 | Number of tests: 6 16:10:41 INFO - PROCESS | 27302 | 16:10:41 INFO - PROCESS | 27302 | [#0] dojo.html Cycles:165 Average:5357.84 Median:5570.89 stddev:587.51 (10.5%) stddev-sans-first:565.42 16:10:41 INFO - PROCESS | 27302 | Values: 3244.2 3265.1 3271.0 3298.2 3312.7 5328.6 5330.1 5347.2 5358.2 5360.8 5355.2 5355.8 5362.2 5365.7 5371.7 4829.5 4838.0 4918.5 4992.3 5001.5 4845.1 4867.9 4912.5 4953.8 4955.6 4904.0 4911.5 4952.7 4960.3 4983.7 4989.5 4990.9 5005.0 5015.4 5036.8 4797.8 4876.6 4889.3 4907.0 4946.0 5303.9 5337.2 5352.6 5360.1 5365.9 5721.5 5800.9 5804.0 5805.0 5806.8 5795.9 5817.8 5856.8 5876.2 5924.2 5393.8 5398.8 5411.6 5442.0 5446.5 5874.5 5955.7 5980.3 5982.3 5984.5 5512.4 5583.7 5605.2 5625.4 5657.2 5709.0 5714.0 5716.8 5717.1 5727.5 5599.2 5688.3 5690.5 5692.7 5727.1 5775.5 5797.6 5801.1 5807.6 5836.7 4404.5 4405.2 4406.6 4407.1 4429.8 3879.6 3923.3 3956.4 3970.3 4016.9 5445.8 5455.1 5474.9 5480.3 5494.4 5663.2 5727.2 5728.3 5730.6 5733.1 5384.4 5419.7 5442.2 5529.1 5529.5 4821.7 4833.2 4859.9 4862.5 4882.3 5856.5 5899.4 5902.6 5907.1 5908.5 5663.9 5711.6 5749.9 5770.4 5786.5 5940.9 5963.1 5999.6 6027.4 6029.8 5570.9 5678.3 5681.5 5695.0 5695.0 5771.4 5820.1 5824.0 5827.3 5865.3 5582.8 5608.4 5627.7 5628.5 5633.7 5498.8 5553.1 5556.3 5563.7 5616.8 5581.6 5601.8 5604.6 5608.7 5643.5 5667.4 5681.9 5684.4 5697.7 5699.5 5475.1 5560.6 5576.4 5623.3 5632.4 16:10:41 INFO - PROCESS | 27302 | 16:10:41 INFO - PROCESS | 27302 | [#1] ext.html Cycles:180 Average:54960.37 Median:23316.35 stddev:102395.39 (439.2%) stddev-sans-first:102601.49 16:10:41 INFO - PROCESS | 27302 | Values: 664.2 680.4 681.4 735.0 750.1 31047.0 31517.0 31613.1 37787.8 39188.2 43828.1 44144.3 44398.0 44464.0 44712.0 8762.1 8936.2 8939.7 8941.2 8948.1 8877.7 9067.0 9071.0 9072.8 9075.0 9050.9 9079.0 9109.4 9115.0 9119.4 9043.1 9050.4 9089.7 9090.5 9096.1 9059.2 9149.5 9165.3 9167.9 9169.8 40141.8 40429.6 40504.0 40535.2 40577.6 3578.3 3710.5 3750.8 4371.4 4737.0 28923.9 31062.2 31920.0 31991.2 32967.7 4243.9 4380.8 4614.1 4614.9 4793.2 220232.0 220329.0 222033.0 222183.0 222801.0 40277.0 58775.0 59216.7 59234.4 59319.7 38302.0 38310.6 38407.8 38444.8 38456.6 17273.5 17415.1 17474.5 17492.4 17492.5 14229.5 14309.9 14360.3 14374.9 14386.2 9320.3 9356.1 9396.7 9506.4 9560.9 3564.7 3592.2 3624.5 3652.9 3725.0 1107.4 1120.4 1151.8 1187.4 1197.6 33631.8 34781.1 35507.0 35687.1 36181.1 1192.8 1211.0 1248.7 1306.5 1310.0 13839.0 17724.6 18506.6 18616.9 18735.4 452783.0 465534.0 467363.0 469962.0 470078.0 60663.7 61602.4 61756.7 61784.4 61809.7 1341.9 1481.4 1518.3 1535.3 1537.6 30526.2 34907.3 36006.5 36110.8 36187.0 61415.1 62430.7 62440.7 62440.7 62487.0 422395.0 428140.0 428925.0 428993.0 431081.0 40571.4 49530.5 51099.5 51327.7 51714.7 48882.0 50937.0 55299.0 55467.4 56746.7 40520.2 40758.0 40795.6 42033.0 45374.5 42388.8 43519.0 43695.6 44398.6 45323.3 45038.0 45255.3 45897.0 46733.5 47168.0 39229.8 40178.6 40786.0 40807.6 41354.2 30556.4 30813.4 31027.0 31164.7 31256.2 16:10:41 INFO - PROCESS | 27302 | 16:10:41 INFO - PROCESS | 27302 | [#2] jquery.html Cycles:180 Average:31927.03 Median:11359.78 stddev:96360.84 (848.3%) stddev-sans-first:96602.12 16:10:41 INFO - PROCESS | 27302 | Values: 422.5 424.2 428.9 429.6 434.5 18725.7 19503.6 19533.3 19810.4 20622.0 19137.8 19352.6 19365.0 19366.6 19393.4 5221.9 5446.4 5831.9 6089.8 6110.9 3964.2 5643.7 5926.6 6003.5 6066.2 5902.9 5924.7 5925.8 5935.2 5941.9 5707.2 5854.6 6076.4 6083.7 6092.8 3810.4 3962.4 5567.4 5843.4 5861.6 13877.4 14018.3 14021.9 14104.5 14135.9 2209.3 2441.4 2627.8 2703.3 2751.5 10310.6 10313.4 10833.0 13046.8 14740.9 2033.8 2097.6 2211.2 2227.8 2326.4 85277.6 85315.0 87432.0 89568.0 89615.0 11128.6 11285.7 11359.4 11616.9 12202.8 15309.6 15459.0 15598.4 15609.0 15624.2 9047.1 9071.7 9104.7 9172.2 9180.0 9313.9 9346.8 9358.3 9397.4 9407.5 5018.3 5034.5 5091.9 5093.8 5114.0 1854.8 2004.8 2034.2 2057.6 2097.9 1005.7 1047.5 1126.5 1128.3 1129.8 19140.9 19353.9 19368.5 19543.0 19739.5 1011.6 1054.9 1057.4 1075.0 1147.7 10538.1 10938.8 10969.4 10986.3 11018.1 563117.0 572142.0 588751.0 598783.0 605669.0 98827.5 98976.5 99635.0 99644.5 100818.0 1132.1 1151.5 1153.6 1157.0 1194.1 17088.7 17230.5 17318.7 17331.9 17453.9 38244.4 38357.0 39586.6 39935.2 40678.4 54179.7 54861.0 56505.4 57132.4 57407.7 8872.2 9081.7 9241.2 9262.7 9352.5 10767.7 12700.9 13561.7 13937.2 14199.8 11894.8 11897.8 12059.3 12197.9 12373.0 11548.2 11678.1 11683.4 12008.6 12165.1 12060.6 12078.1 12105.6 12186.0 12456.1 8861.3 8929.9 8957.5 9146.4 9205.0 12131.0 12152.9 12284.5 12414.9 12585.6 16:10:41 INFO - PROCESS | 27302 | 16:10:41 INFO - PROCESS | 27302 | [#3] mootools.html Cycles:180 Average:5522.57 Median:5052.18 stddev:2919.48 (57.8%) stddev-sans-first:2911.61 16:10:41 INFO - PROCESS | 27302 | Values: 1448.5 1566.5 1577.2 1794.9 1945.1 8049.1 8200.3 8264.2 8284.4 8296.4 8151.0 8300.6 8300.8 8301.0 8304.6 2468.7 2489.1 2490.8 2493.6 2493.8 2451.9 2493.7 2500.6 2515.3 2518.6 2433.5 2455.9 2457.2 2457.4 2457.8 2409.9 2416.0 2432.1 2475.6 2485.7 2425.3 2453.8 2458.0 2467.5 2515.2 7928.6 8006.6 8343.4 8376.1 8400.5 5201.1 5299.4 5301.2 5301.9 5307.4 3513.7 3557.2 3568.7 3577.8 3610.2 1191.6 1213.4 1215.5 1233.5 1264.7 11372.1 11399.5 11468.7 11474.0 11530.4 4471.5 4604.9 4616.9 4638.7 4651.2 9215.9 9219.4 9233.0 9239.2 9244.4 5331.1 5333.7 5335.9 5338.9 5339.4 4281.2 4786.4 4934.1 4963.1 4963.1 3827.5 3863.8 3915.8 3916.2 3961.4 1194.6 1212.8 1215.0 1216.4 1229.8 944.3 1038.8 1050.2 1053.3 1056.9 5755.3 5874.2 5884.5 5917.3 6108.7 952.4 1018.5 1046.6 1080.1 1097.5 3917.2 4042.1 4043.1 4088.2 4089.5 9943.7 10207.4 10242.6 10257.1 10276.8 9927.1 10111.7 10123.9 10131.8 10143.9 7671.5 7865.4 7868.1 7877.5 7878.2 5425.6 5553.2 5563.4 5677.5 5755.7 8443.2 8456.5 8570.1 8813.8 8995.8 8623.7 8802.0 8840.5 8890.9 8902.8 6691.9 7154.0 7261.9 7269.2 7336.1 7863.3 7886.7 7951.1 7953.4 7962.6 6817.9 7165.2 7184.8 7188.6 7321.9 7128.6 7204.6 7218.3 7233.2 7317.9 6795.2 6851.7 6852.0 6853.1 6863.5 4954.8 5030.3 5074.0 5094.4 5107.2 4874.3 4935.2 4997.0 5117.1 5198.2 16:10:41 INFO - PROCESS | 27302 | 16:10:41 INFO - PROCESS | 27302 | [#4] prototype.html Cycles:180 Average:5397.96 Median:6161.43 stddev:1639.99 (26.6%) stddev-sans-first:1600.29 16:10:41 INFO - PROCESS | 27302 | Values: 353.8 356.3 359.3 359.4 361.2 6080.6 6081.1 6138.1 6141.5 6153.6 6064.3 6071.8 6078.9 6092.0 6099.1 4442.0 4569.2 4657.6 4688.9 4691.3 4666.9 4678.1 4680.1 4684.1 4707.8 4439.0 4647.3 4659.7 4661.5 4668.7 4518.4 4562.7 4570.0 4643.8 4650.8 4096.3 4108.2 4114.2 4116.5 4118.1 5842.2 5846.2 5861.1 5861.5 5863.0 5392.7 5394.6 5401.9 5414.6 5414.7 6367.5 6379.4 6390.8 6395.7 6397.6 4293.7 4446.7 4451.7 4454.6 4454.6 6571.7 6656.4 6664.2 6681.2 6682.1 4545.6 4545.7 4552.2 4553.2 4553.6 4590.4 4595.6 4602.6 4605.6 4606.1 5311.8 5322.6 5328.3 5336.3 5338.8 6191.4 6401.0 6405.9 6442.9 6462.2 1577.3 1579.3 1588.4 1590.8 1591.8 995.1 1037.0 1045.6 1048.5 1055.7 6169.2 6258.9 6278.1 6280.6 6284.0 6613.2 6620.7 6697.5 6705.5 6712.1 6274.4 6329.8 6332.8 6341.4 6343.4 3545.1 3590.9 3591.8 3592.4 3593.4 6824.2 6978.9 6981.1 7006.3 7011.1 6773.8 6791.2 6805.5 6808.4 6810.6 6975.6 6978.2 6980.9 6983.9 6988.1 6666.6 6697.4 6698.6 6701.5 6704.7 6328.4 6538.0 6539.5 6594.8 6594.8 6935.1 6955.8 6980.5 6992.0 6996.4 4528.0 4565.5 4565.6 4567.5 4578.0 6628.8 6640.8 6655.5 6657.0 6664.7 6345.6 6461.6 6465.1 6466.5 6470.7 6437.9 6462.2 6464.5 6467.5 6468.5 6357.5 6361.8 6372.1 6372.2 6381.6 6494.6 6496.9 6510.3 6510.7 6525.9 5961.4 6084.5 6340.4 6350.3 6359.3 16:10:41 INFO - PROCESS | 27302 | 16:10:41 INFO - PROCESS | 27302 | [#5] yui.html Cycles:180 Average:15640.29 Median:4751.52 stddev:17758.21 (373.7%) stddev-sans-first:17773.51 16:10:41 INFO - PROCESS | 27302 | Values: 896.2 906.3 912.3 912.8 914.6 14543.3 14731.9 14737.6 14805.0 17020.0 16073.0 16165.4 16188.6 16193.8 16235.0 749.1 907.0 923.0 923.2 930.1 896.4 901.1 904.6 904.7 907.2 965.2 965.3 965.4 965.6 966.6 782.4 947.4 957.6 957.7 967.5 688.9 693.1 693.7 700.7 702.0 14999.5 15052.6 15068.7 15078.8 15083.2 13935.2 14168.6 14249.8 14257.2 14514.5 11739.9 11881.4 11917.2 12077.6 12233.7 4671.2 4746.3 4746.4 4756.6 4833.9 56216.4 56808.0 56821.7 56907.1 56990.4 11038.7 11298.1 11317.2 11822.8 12018.8 20025.8 20169.0 20182.8 20212.9 20238.8 8577.4 8862.0 8863.2 8909.3 8911.0 4933.8 5013.4 5029.6 5097.1 5202.0 3509.3 3568.7 3570.9 3576.2 3579.6 610.5 612.9 613.4 615.4 615.9 631.2 697.6 748.8 771.0 775.6 9592.2 9615.8 9660.7 9669.7 9712.4 742.8 768.5 774.1 787.2 807.9 4524.3 4544.1 4599.4 4619.8 4687.7 63047.7 63738.4 64418.0 64425.0 70745.6 55032.4 55604.0 55638.4 55891.0 57645.0 50636.5 51078.0 51262.2 51368.0 51876.2 9549.4 9743.4 9799.0 9859.1 9926.3 37566.6 38237.6 38361.6 39973.6 39976.2 43741.0 44005.8 47263.5 49638.8 50126.2 12804.9 12845.2 12955.9 13041.7 13119.3 13346.5 13433.3 14082.0 14339.9 15306.7 13152.9 13891.4 14130.6 14161.6 14649.5 12855.2 13162.0 13749.6 13910.0 14049.6 11858.6 12078.8 12272.2 12513.3 12516.4 11365.0 11458.9 11745.8 11781.8 11977.4 11513.4 11582.4 11620.8 11770.9 11849.3 16:10:41 INFO - PROCESS | 27302 | -------- Summary: end -------- 16:10:41 INFO - PROCESS | 27302 | 16:10:42 INFO - TEST-INFO | 27302: exit 0 16:10:42 INFO - TEST-OK | dromaeo_css | took 1112367ms 16:10:42 INFO - TEST-START | kraken 16:10:42 INFO - operating with platform_type : linux_ 16:10:42 INFO - Initialising browser for kraken test... 16:10:42 INFO - TEST-INFO | started process 27496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD2lVOX/profile http://localhost:59975/getInfo.html) 16:10:46 INFO - PROCESS | 27496 | __metrics Screen width/height:1600/1200 16:10:46 INFO - PROCESS | 27496 | colorDepth:24 16:10:46 INFO - PROCESS | 27496 | Browser inner width/height: 1024/697 16:10:46 INFO - PROCESS | 27496 | __metrics 16:10:47 ERROR - PROCESS | 27496 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:10:48 INFO - TEST-INFO | 27496: exit 0 16:10:48 INFO - Browser initialized. 16:10:48 INFO - Running cycle 1/1 for kraken test... 16:10:48 INFO - TEST-INFO | started process 27591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD2lVOX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:59 INFO - PROCESS | 27591 | RSS: Main: 139337728 16:10:59 INFO - PROCESS | 27591 | 16:11:02 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:59975/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59975/tests/kraken/driver.html?testName=audio-beat-detection) 16:11:03 INFO - PROCESS | 27591 | RSS: Main: 197058560 16:11:03 INFO - PROCESS | 27591 | 16:11:05 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:59975/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59975/tests/kraken/driver.html?testName=audio-dft) 16:11:06 INFO - PROCESS | 27591 | RSS: Main: 185094144 16:11:06 INFO - PROCESS | 27591 | 16:11:09 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:59975/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59975/tests/kraken/driver.html?testName=audio-fft) 16:11:09 INFO - PROCESS | 27591 | RSS: Main: 274284544 16:11:09 INFO - PROCESS | 27591 | 16:11:11 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:59975/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59975/tests/kraken/driver.html?testName=audio-oscillator) 16:11:12 INFO - PROCESS | 27591 | RSS: Main: 180461568 16:11:12 INFO - PROCESS | 27591 | 16:11:14 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:59975/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59975/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:11:15 INFO - PROCESS | 27591 | RSS: Main: 177598464 16:11:15 INFO - PROCESS | 27591 | 16:11:18 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:59975/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59975/tests/kraken/driver.html?testName=imaging-darkroom) 16:11:18 INFO - PROCESS | 27591 | RSS: Main: 212914176 16:11:18 INFO - PROCESS | 27591 | 16:11:22 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:59975/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59975/tests/kraken/driver.html?testName=imaging-desaturate) 16:11:22 INFO - PROCESS | 27591 | RSS: Main: 213491712 16:11:22 INFO - PROCESS | 27591 | 16:11:25 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:59975/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59975/tests/kraken/driver.html?testName=json-parse-financial) 16:11:26 INFO - PROCESS | 27591 | RSS: Main: 212746240 16:11:26 INFO - PROCESS | 27591 | 16:11:27 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:59975/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59975/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:11:28 INFO - PROCESS | 27591 | RSS: Main: 195792896 16:11:28 INFO - PROCESS | 27591 | 16:11:29 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:59975/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59975/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:11:30 INFO - PROCESS | 27591 | RSS: Main: 197591040 16:11:30 INFO - PROCESS | 27591 | 16:11:32 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:59975/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59975/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:11:33 INFO - PROCESS | 27591 | RSS: Main: 208470016 16:11:33 INFO - PROCESS | 27591 | 16:11:35 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:59975/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59975/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:11:36 INFO - PROCESS | 27591 | RSS: Main: 216301568 16:11:36 INFO - PROCESS | 27591 | 16:11:38 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:59975/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59975/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:11:39 INFO - PROCESS | 27591 | RSS: Main: 212369408 16:11:39 INFO - PROCESS | 27591 | 16:11:41 INFO - PROCESS | 27591 | Cycle 1(1): loaded http://localhost:59975/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59975/tests/kraken/driver.html?testName=ai-astar) 16:11:41 INFO - PROCESS | 27591 | RSS: Main: 273014784 16:11:41 INFO - PROCESS | 27591 | 16:11:41 INFO - PROCESS | 27591 | __start_tp_report 16:11:41 INFO - PROCESS | 27591 | _x_x_mozilla_page_load 16:11:41 INFO - PROCESS | 27591 | _x_x_mozilla_page_load_details 16:11:41 INFO - PROCESS | 27591 | |i|pagename|runs| 16:11:41 INFO - PROCESS | 27591 | |0;ai-astar;110;110;111;110;110;111;106;110;111;109 16:11:41 INFO - PROCESS | 27591 | |1;audio-beat-detection;159;126;155;173;126;157;148;129;181;125 16:11:41 INFO - PROCESS | 27591 | |2;audio-dft;161;162;162;159;162;161;160;166;160;161 16:11:41 INFO - PROCESS | 27591 | |3;audio-fft;76;77;76;172;74;76;77;76;159;75 16:11:41 INFO - PROCESS | 27591 | |4;audio-oscillator;93;91;152;93;91;91;153;91;91;157 16:11:41 INFO - PROCESS | 27591 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;116;117;117 16:11:41 INFO - PROCESS | 27591 | |6;imaging-darkroom;149;148;148;148;148;148;148;148;148;145 16:11:41 INFO - PROCESS | 27591 | |7;imaging-desaturate;95;95;95;95;94;95;95;94;94;94 16:11:41 INFO - PROCESS | 27591 | |8;json-parse-financial;57;53;53;53;54;54;55;78;52;53 16:11:41 INFO - PROCESS | 27591 | |9;json-stringify-tinderbox;57;58;57;57;57;58;58;57;58;57 16:11:41 INFO - PROCESS | 27591 | |10;stanford-crypto-aes;73;73;75;73;73;75;74;80;75;74 16:11:41 INFO - PROCESS | 27591 | |11;stanford-crypto-ccm;119;116;115;115;117;115;116;134;129;116 16:11:41 INFO - PROCESS | 27591 | |12;stanford-crypto-pbkdf2;166;166;164;163;160;161;164;161;167;160 16:11:41 INFO - PROCESS | 27591 | |13;stanford-crypto-sha256-iterative;66;65;67;70;65;65;66;66;67;67 16:11:41 INFO - PROCESS | 27591 | __end_tp_report 16:11:41 INFO - PROCESS | 27591 | __start_cc_report 16:11:41 INFO - PROCESS | 27591 | _x_x_mozilla_cycle_collect,1596 16:11:41 INFO - PROCESS | 27591 | __end_cc_report 16:11:41 INFO - PROCESS | 27591 | __startTimestamp1467241901457__endTimestamp 16:11:41 INFO - PROCESS | 27591 | 16:11:41 INFO - PROCESS | 27591 | ------- Summary: start ------- 16:11:41 INFO - PROCESS | 27591 | Number of tests: 14 16:11:41 INFO - PROCESS | 27591 | 16:11:41 INFO - PROCESS | 27591 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:1.48 (1.3%) stddev-sans-first:1.56 16:11:41 INFO - PROCESS | 27591 | Values: 110.0 110.0 111.0 110.0 110.0 111.0 106.0 110.0 111.0 109.0 16:11:41 INFO - PROCESS | 27591 | 16:11:41 INFO - PROCESS | 27591 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:156.00 stddev:20.61 (13.2%) stddev-sans-first:21.47 16:11:41 INFO - PROCESS | 27591 | Values: 159.0 126.0 155.0 173.0 126.0 157.0 148.0 129.0 181.0 125.0 16:11:41 INFO - PROCESS | 27591 | 16:11:41 INFO - PROCESS | 27591 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.90 (1.2%) stddev-sans-first:2.01 16:11:41 INFO - PROCESS | 27591 | Values: 161.0 162.0 162.0 159.0 162.0 161.0 160.0 166.0 160.0 161.0 16:11:41 INFO - PROCESS | 27591 | 16:11:41 INFO - PROCESS | 27591 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.00 stddev:37.92 (49.9%) stddev-sans-first:39.67 16:11:41 INFO - PROCESS | 27591 | Values: 76.0 77.0 76.0 172.0 74.0 76.0 77.0 76.0 159.0 75.0 16:11:41 INFO - PROCESS | 27591 | 16:11:41 INFO - PROCESS | 27591 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:91.00 stddev:30.19 (33.2%) stddev-sans-first:31.37 16:11:41 INFO - PROCESS | 27591 | Values: 93.0 91.0 152.0 93.0 91.0 91.0 153.0 91.0 91.0 157.0 16:11:41 INFO - PROCESS | 27591 | 16:11:41 INFO - PROCESS | 27591 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:11:41 INFO - PROCESS | 27591 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 16:11:41 INFO - PROCESS | 27591 | 16:11:41 INFO - PROCESS | 27591 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.00 16:11:41 INFO - PROCESS | 27591 | Values: 149.0 148.0 148.0 148.0 148.0 148.0 148.0 148.0 148.0 145.0 16:11:41 INFO - PROCESS | 27591 | 16:11:41 INFO - PROCESS | 27591 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:11:41 INFO - PROCESS | 27591 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 94.0 16:11:41 INFO - PROCESS | 27591 | 16:11:41 INFO - PROCESS | 27591 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:54.00 stddev:7.79 (14.4%) stddev-sans-first:8.25 16:11:41 INFO - PROCESS | 27591 | Values: 57.0 53.0 53.0 53.0 54.0 54.0 55.0 78.0 52.0 53.0 16:11:41 INFO - PROCESS | 27591 | 16:11:41 INFO - PROCESS | 27591 | [#9] json-stringify-tinderbox Cycles:10 Average:57.40 Median:57.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 16:11:41 INFO - PROCESS | 27591 | Values: 57.0 58.0 57.0 57.0 57.0 58.0 58.0 57.0 58.0 57.0 16:11:41 INFO - PROCESS | 27591 | 16:11:41 INFO - PROCESS | 27591 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.50 stddev:2.12 (2.8%) stddev-sans-first:2.18 16:11:41 INFO - PROCESS | 27591 | Values: 73.0 73.0 75.0 73.0 73.0 75.0 74.0 80.0 75.0 74.0 16:11:41 INFO - PROCESS | 27591 | 16:11:41 INFO - PROCESS | 27591 | [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:116.50 stddev:6.70 (5.7%) stddev-sans-first:7.10 16:11:41 INFO - PROCESS | 27591 | Values: 119.0 116.0 115.0 115.0 117.0 115.0 116.0 134.0 129.0 116.0 16:11:41 INFO - PROCESS | 27591 | 16:11:41 INFO - PROCESS | 27591 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:164.00 stddev:2.62 (1.6%) stddev-sans-first:2.57 16:11:41 INFO - PROCESS | 27591 | Values: 166.0 166.0 164.0 163.0 160.0 161.0 164.0 161.0 167.0 160.0 16:11:41 INFO - PROCESS | 27591 | 16:11:41 INFO - PROCESS | 27591 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.51 (2.3%) stddev-sans-first:1.59 16:11:41 INFO - PROCESS | 27591 | Values: 66.0 65.0 67.0 70.0 65.0 65.0 66.0 66.0 67.0 67.0 16:11:41 INFO - PROCESS | 27591 | -------- Summary: end -------- 16:11:41 INFO - PROCESS | 27591 | 16:11:42 INFO - TEST-INFO | 27591: exit 0 16:11:42 INFO - TEST-OK | kraken | took 60133ms 16:11:42 INFO - SUITE-END | took 1172s 16:11:42 INFO - Completed test suite (00:19:32) 16:11:42 INFO - javascript benchmark 16:11:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3244.1565193049805, 3265.1184180271325, 3270.9509357359634, 3298.175456135966, 3312.734981201504, 5328.573714102872, 5330.1205301125365, 5347.197920311955, 5358.249845021695, 5360.839174824751, 5355.223492593581, 5355.758990845412, 5362.2224777407255, 5365.651232669874, 5371.650842695222, 4829.492903245161, 4837.975810120954, 4918.508149185071, 4992.32603598515, 5001.524855138774, 4845.055214233226, 4867.902641947159, 4912.48418916014, 4953.752312384385, 4955.554000139987, 4903.9754801225945, 4911.5088491150955, 4952.702837829742, 4960.305557221992, 4983.6760610560195, 4989.525995030484, 4990.925136122924, 5005.0, 5015.448300686921, 5036.848894533152, 4797.808087676489, 4876.60987121033, 4889.33993910821, 4906.975465122688, 4946.035523073002, 5303.867403314909, 5337.226102215157, 5352.598555108382, 5360.115580929142, 5365.892682146375, 5721.456461636138, 5800.941990580124, 5803.9709801451145, 5805.042168042311, 5806.796762113306, 5795.884082318372, 5817.825465236049, 5856.76572937082, 5876.206712093898, 5924.170616113747, 5393.7572809223675, 5398.838034858961, 5411.621186516984, 5442.0, 5446.455354464521, 5874.500667443315, 5955.702214889325, 5980.252468441445, 5982.282126144891, 5984.461398474158, 5512.39363669996, 5583.748731307101, 5605.215269862222, 5625.38120806711, 5657.179708942181, 5708.9723849706625, 5714.028615135437, 5716.7994721109035, 5717.056685646821, 5727.455891690282, 5599.216109744639, 5688.288963879515, 5690.5163061140265, 5692.658440493584, 5727.140928860705, 5775.451332123442, 5797.565182611321, 5801.071828507418, 5807.622504537191, 5836.67898265591, 4404.515503294635, 4405.207062728739, 4406.647468202536, 4407.096545208225, 4429.82280708768, 3879.553851307136, 3923.2938071146896, 3956.40653901917, 3970.285348637215, 4016.9196616067516, 5445.782168713207, 5455.1271796512365, 5474.890502190014, 5480.314960629921, 5494.423085576037, 5663.1505274208375, 5727.198192253088, 5728.283964504437, 5730.598858079978, 5733.111367738007, 5384.380796208407, 5419.701916394557, 5442.2108794225405, 5529.087700529368, 5529.502344788988, 4821.734804585712, 4833.202521583969, 4859.878503037452, 4862.5380588844, 4882.340883980688, 5856.531477481792, 5899.351071382144, 5902.61632993854, 5907.054871220584, 5908.468237858528, 5663.858403539944, 5711.600187986801, 5749.8562535936935, 5770.422957704196, 5786.537077033911, 5940.910886336795, 5963.075723262901, 5999.610025348338, 6027.427394397525, 6029.758809647565, 5570.888582228252, 5678.346990096192, 5681.545476361964, 5694.971525142348, 5695.0, 5771.3651498335985, 5820.097884827858, 5824.039033559416, 5827.329857066492, 5865.3254875688135, 5582.8325150245555, 5608.38307786135, 5627.690477023803, 5628.465295796893, 5633.718314084362, 5498.835034948958, 5553.08374118266, 5556.277683901067, 5563.7496312666835, 5616.803411880564, 5581.609287349846, 5601.7759289629585, 5604.579656525695, 5608.747606357642, 5643.52030077448, 5667.404922483245, 5681.886362272814, 5684.403137670651, 5697.7151142443545, 5699.487046165865, 5475.123980163155, 5560.610757246954, 5576.442355764391, 5623.268975033219, 5632.352279487911], "value": 5320.22994578155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.2195420381051, 680.3774546290144, 681.4003676764446, 735.0407717928105, 750.0811505905267, 31047.0, 31517.0, 31613.051608451755, 37787.81106094466, 39188.21623567527, 43828.12343753123, 44144.33783493242, 44398.0, 44464.0, 44712.0, 8762.123787621234, 8936.195742383185, 8939.687110951118, 8941.150590693873, 8948.06045365237, 8877.73366798997, 9066.954665226665, 9070.954645226764, 9072.818543629124, 9075.047120052399, 9050.86423703645, 9079.0, 9109.362344635878, 9115.0, 9119.361644684876, 9043.050479699636, 9050.366474346798, 9089.727308180733, 9090.545472726337, 9096.135867092615, 9059.18467337936, 9149.451032938045, 9165.312601554844, 9167.908320916838, 9169.77075573116, 40141.79929100365, 40429.595704043175, 40504.0, 40535.18929621391, 40577.59422405768, 3578.3380074686265, 3710.5176327077306, 3750.8124593770476, 4371.388005679208, 4737.028909073631, 28923.855380723173, 31062.223444413845, 31920.0, 31991.200219994455, 32967.6703232967, 4243.915121697549, 4380.824767009348, 4614.123316569875, 4614.9077018459775, 4793.161196790583, 220231.9999999984, 220329.0, 222033.0, 222183.0, 222801.0, 40277.0, 58775.0, 59216.70391648014, 59234.40765592375, 59319.703401482715, 38302.0, 38310.6168938307, 38407.80796096002, 38444.807775960944, 38456.615433845305, 17273.481795546155, 17415.129243537773, 17474.47576572705, 17492.387766428114, 17492.47522574325, 14229.50196743109, 14309.856901430852, 14360.281985900663, 14374.928125359516, 14386.208758518382, 9320.347575669774, 9356.111169438893, 9396.718098457057, 9506.382085164441, 9560.856587151198, 3564.7326450515798, 3592.2038980509747, 3624.5469316335457, 3652.8904132876055, 3724.9627503724614, 1107.44074242507, 1120.4173829608558, 1151.844500992372, 1187.4122309456702, 1197.5628895453272, 33631.83184084064, 34781.13047173841, 35507.0, 35687.10782230465, 36181.09547261339, 1192.7793358228755, 1210.9697257568632, 1248.7252804383022, 1306.45129045801, 1309.9782169907487, 13838.980043681031, 17724.645507089786, 18506.629867402575, 18616.906915465337, 18735.437936861916, 452783.0, 465534.0, 467363.0, 469962.0, 470078.0, 60663.69668151719, 61602.38397616056, 61756.69121654363, 61784.38215617876, 61809.69095154495, 1341.8792308692264, 1481.4222453243244, 1518.3471107423693, 1535.332130523226, 1537.5848520899517, 30526.236844078187, 34907.30185396227, 36006.45990310095, 36110.819445902605, 36187.0, 61415.078773819325, 62430.687846560475, 62440.68779656073, 62440.68779656073, 62487.0, 422395.0, 428140.0, 428925.0, 428993.0, 431081.0, 40571.39142912918, 49530.504694952586, 51099.48900511096, 51327.743361282955, 51714.741426292625, 48882.0, 50936.98126037532, 55299.0, 55467.44532554623, 56746.71626642006, 40520.189596208504, 40758.0, 40795.59204407918, 42033.0, 45374.54625453703, 42388.78805605952, 43519.0, 43695.56304436915, 44398.55601443944, 45323.32015019843, 45038.0, 45255.321170181815, 45897.0, 46733.532664672915, 47168.0, 39229.80385098056, 40178.59821401865, 40786.0, 40807.59192408038, 41354.172916542106, 30556.388872222877, 30813.383732325678, 31027.0, 31164.68835311618, 31256.21859453532], "value": 19910.2605370651, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.4698004004973, 424.2490791299402, 428.8842012656581, 429.6240789309354, 434.4504202184236, 18725.719114213298, 19503.609927801437, 19533.316333928316, 19810.40568782939, 20622.0, 19137.808621913777, 19352.612947741036, 19365.0, 19366.612667746638, 19393.4181974541, 5221.895562088756, 5446.428125046872, 5831.883362332751, 6089.756409743605, 6110.908336374936, 3964.2071585682834, 5643.68959707216, 5926.644401335912, 6003.459688628022, 6066.241719785027, 5902.911456328158, 5924.674142922137, 5925.762969481216, 5935.228420305376, 5941.88116237675, 5707.200991861122, 5854.560907931901, 6076.3923607639545, 6083.665398403086, 6092.756289748405, 3810.447485114643, 3962.3660214365564, 5567.387587365387, 5843.3864444233595, 5861.560382971252, 13877.37551810171, 14018.299085045706, 14021.85978140226, 14104.506342277971, 14135.929320353333, 2209.304069218191, 2441.426264827764, 2627.750363715444, 2703.2701170684004, 2751.477219328341, 10310.639127630571, 10313.381197128121, 10833.0, 13046.804297935538, 14740.926295368561, 2033.7864524224892, 2097.5699981503753, 2211.248175620297, 2227.7994980451836, 2326.4067662745892, 85277.57361213217, 85315.0, 87432.0, 89568.0, 89614.99999999935, 11128.554857805597, 11285.661430157108, 11359.432028398713, 11616.94191529037, 12202.755944881053, 15309.6172595686, 15459.0, 15598.376064957502, 15609.0, 15624.203216630005, 9047.140521650434, 9071.727848164566, 9104.681336153202, 9172.174504294646, 9179.954100229455, 9313.90686093144, 9346.813063738688, 9358.344915855962, 9397.436153830791, 9407.529623518796, 5018.347614810052, 5034.496550344937, 5091.949080509222, 5093.796248150106, 5114.028334616411, 1854.7665802241359, 2004.829589484881, 2034.2371610646007, 2057.6193404220267, 2097.947551311199, 1005.6580762540772, 1047.5024363427463, 1126.5437497813234, 1128.311729844794, 1129.836173754801, 19140.904295478435, 19353.903230483756, 19368.515787105152, 19543.0228488575, 19739.506512337306, 1011.630754774502, 1054.920880933933, 1057.4289883462998, 1074.9623763168252, 1147.6671765188003, 10538.104261137889, 10938.781224375469, 10969.396683182342, 10986.285891417032, 11018.11855051594, 563117.0, 572142.0, 588751.0, 598783.0, 605669.0, 98827.50586247022, 98976.50511747395, 99635.0, 99644.5017774921, 100818.0, 1132.0830127596673, 1151.5451396698425, 1153.6366044695894, 1157.028096399012, 1194.116353898109, 17088.658226835643, 17230.483085507454, 17318.65362692714, 17331.913340433217, 17453.912730436266, 38244.42633360446, 38357.0, 39586.604133958295, 39935.20129597334, 40678.38982415207, 54179.72910135582, 54861.0, 56505.43494565002, 57132.42867571271, 57407.712961434925, 8872.157145071207, 9081.68214112503, 9241.168294853227, 9262.675806346746, 9352.53237338144, 10767.730806729895, 12700.936495317465, 13561.660958476117, 13937.163770173416, 14199.787003194753, 11894.821577676516, 11897.762044759229, 12059.336736479227, 12197.939010304892, 12373.0, 11548.249363791327, 11678.06575473977, 11683.415829208676, 12008.63974080779, 12165.08761842883, 12060.638180854588, 12078.094142939139, 12105.576304829288, 12186.0, 12456.12807103494, 8861.33539984491, 8929.910700892908, 8957.507337096522, 9146.405483643808, 9204.95397523008, 12131.0, 12152.878471215528, 12284.508619655113, 12414.875851241371, 12585.622431327074], "value": 9516.265502610602, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.4568286892415, 1566.5378713279579, 1577.2350410051126, 1794.9012804295767, 1945.124693887751, 8049.07435644901, 8200.302974247188, 8264.173582641733, 8284.378671599632, 8296.377771667134, 8150.9592452037805, 8300.584970751468, 8300.792480187998, 8300.958495207531, 8304.584770761452, 2468.6790717206736, 2489.141246270043, 2490.8256422050463, 2493.551160791057, 2493.7880280176205, 2451.9264422067367, 2493.6758221431187, 2500.5624015797252, 2515.270571534262, 2518.647389365481, 2433.4768024874647, 2455.9263222103364, 2457.1522824625563, 2457.373369790701, 2457.7588317899526, 2409.891554880026, 2415.9637605435846, 2432.1122790181544, 2475.6410320503605, 2485.726570077308, 2425.260295609838, 2453.815963802722, 2458.0167932826835, 2467.481828815951, 2515.195137555983, 7928.603569821544, 8006.599670016476, 8343.415960882741, 8376.078631350547, 8400.453970491959, 5201.063808514466, 5299.390570084451, 5301.231321458367, 5301.920471192935, 5307.416184219733, 3513.7013353864954, 3557.1818481749083, 3568.7323450741037, 3577.8032208228537, 3610.1696609779897, 1191.6365508519898, 1213.3690480949856, 1215.4773447417606, 1233.5250928392634, 1264.740728150727, 11372.14708896836, 11399.48702308398, 11468.655940321803, 11474.024707899838, 11530.42347882611, 4471.463424389094, 4604.861854144381, 4616.8614941551805, 4638.698484598491, 4651.162790697707, 9215.861762073575, 9219.354645174773, 9232.953835230916, 9239.168474837297, 9244.445333280024, 5331.1470164773455, 5333.733313334318, 5335.919961200585, 5338.91991620126, 5339.385970613429, 4281.2293787118, 4786.377770889762, 4934.136526107916, 4963.057019166346, 4963.106640804617, 3827.4641550182996, 3863.8068096595057, 3915.8433662653174, 3916.2167566486814, 3961.3859851723028, 1194.5878671858368, 1212.781699294118, 1214.969625759363, 1216.3796463803346, 1229.7786398448186, 944.2964991081689, 1038.8078205532001, 1050.1861057680205, 1053.2679787547734, 1056.8890266521905, 5755.3381361143165, 5874.206982057368, 5884.5273895277805, 5917.319508256605, 6108.725107370179, 952.4333021851987, 1018.5212949913529, 1046.6179844356755, 1080.1143062688677, 1097.4896673047072, 3917.2361389529337, 4042.0703238255364, 4043.110515686544, 4088.2436749200897, 4089.5092588889524, 9943.701688949342, 10207.438590877424, 10242.641507547349, 10257.128144107684, 10276.794464110826, 9927.056929591678, 10111.747206319753, 10123.898761012442, 10131.848022279672, 10143.898561014443, 7671.462997590115, 7865.449418540762, 7868.0951690555175, 7877.527348359117, 7878.212178782191, 5425.593080519056, 5553.194786755978, 5563.443655634404, 5677.460641239076, 5755.683437410982, 8443.197896199852, 8456.450330728483, 8570.057293697564, 8813.823723525622, 8995.775105622412, 8623.65505379803, 8802.0, 8840.469571825712, 8890.866637000321, 8902.821943561223, 6691.933080669131, 7154.0, 7261.891071634035, 7269.236730143259, 7336.119665640157, 7863.292303692695, 7886.684532618631, 7951.125376208728, 7953.443258971816, 7962.601869906365, 6817.89773153413, 7165.176004759519, 7184.820379490555, 7188.640567971476, 7321.890171647536, 7128.643567821692, 7204.639768011473, 7218.27817218274, 7233.204347521663, 7317.926820731725, 6795.218549866631, 6851.657417129024, 6851.9657401712675, 6853.109095817512, 6863.519553631398, 4954.777035033504, 5030.346055012825, 5074.010567939216, 5094.363204599425, 5107.208382700687, 4874.317595536557, 4935.185694360391, 4996.950030499648, 5117.1300878851425, 5198.246254293031], "value": 4556.189226082232, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.84430850425827, 356.342547998942, 359.2904014571221, 359.41236079010815, 361.22877656203997, 6080.6351618902845, 6081.148639190511, 6138.140660307555, 6141.539384546155, 6153.630782153074, 6064.302605200403, 6071.757129714806, 6078.908816367758, 6091.969540152293, 6099.115628233914, 4441.977790111053, 4569.200389931765, 4657.5575320344515, 4688.859334219962, 4691.29630555416, 4666.883327916796, 4678.134545109166, 4680.063987202556, 4684.1334353144775, 4707.764611769415, 4439.0, 4647.279671650883, 4659.720416775004, 4661.510541393156, 4668.743219122947, 4518.367428560005, 4562.703424277428, 4570.040291538781, 4643.791029403685, 4650.790714417825, 4096.283150448659, 4108.1783643271465, 4114.177164567069, 4116.464859568267, 4118.114605359862, 5842.24050873388, 5846.21076154718, 5861.091530812688, 5861.531077513789, 5862.97068514659, 5392.703401312926, 5394.649347792381, 5401.918971215435, 5414.648047876875, 5414.700471886719, 6367.4906007519285, 6379.36206379363, 6390.840228994312, 6395.744170233185, 6397.552171347961, 4293.656507479394, 4446.666500012479, 4451.666125040602, 4454.57681520255, 4454.643628509712, 6571.671416429207, 6656.434203092695, 6664.233613134503, 6681.231658359254, 6682.064510968468, 4545.568171023748, 4545.704529205591, 4552.226121559343, 4553.248713962159, 4553.61294289989, 4590.380298659705, 4595.632349412039, 4602.585767280961, 4605.608523275492, 4606.124836281096, 5311.814086506954, 5322.627416080837, 5328.333958255218, 5336.279602253724, 5338.786448542092, 6191.380861913863, 6400.967995159995, 6405.903911441332, 6442.9355706443275, 6462.224533056064, 1577.345401658299, 1579.2972127403195, 1588.3884704388893, 1590.7931968843977, 1591.785109010292, 995.0894931138073, 1036.9637062702768, 1045.639254457211, 1048.533402635835, 1055.7149569616315, 6169.2288463942, 6258.906116408258, 6278.058291256257, 6280.623162610258, 6284.0, 6613.206415230203, 6620.668966551653, 6697.497687673444, 6705.530612857053, 6712.060311556386, 6274.435300822856, 6329.841753956188, 6332.810015699536, 6341.429271365507, 6343.397377249154, 3545.1137215696076, 3590.9281814363567, 3591.838367273479, 3592.407252803258, 3593.3531964246163, 6824.18109826824, 6978.895316570255, 6981.127359080115, 7006.334398232159, 7011.088558487466, 6773.796786096425, 6791.219009813836, 6805.455563554904, 6808.4212841908, 6810.557313774688, 6975.581465112109, 6978.232394436608, 6980.895286570705, 6983.930160698328, 6988.091548098816, 6666.633335166613, 6697.397234248941, 6698.631575263407, 6701.497387696039, 6704.731810727516, 6328.430441260309, 6537.953927371597, 6539.4768418525455, 6594.802155935329, 6594.8351291218105, 6935.133108361455, 6955.791326260221, 6980.51136420466, 6992.0, 6996.370326670624, 4528.0, 4565.452145742533, 4565.589096981287, 4567.474740404896, 4577.977110114428, 6628.83427914306, 6640.800775976729, 6655.534112612264, 6657.0, 6664.666766661744, 6345.555811093179, 6461.64460954652, 6465.0948867157695, 6466.482681385572, 6470.7088181032905, 6437.903431448438, 6462.159919210472, 6464.547481676237, 6467.514936379696, 6468.450181734605, 6357.523185760994, 6361.809145725636, 6372.0760489729655, 6372.203474565679, 6381.649009304533, 6494.577852439766, 6496.902546461902, 6510.251321097945, 6510.73957041713, 6525.902111468236, 5961.433663801932, 6084.482818960438, 6340.4293613575, 6350.269718982377, 6359.332270111571], "value": 4863.934785154415, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [896.1934259166745, 906.2613969614765, 912.2792993535107, 912.8083102548464, 914.6204325205036, 14543.345549450274, 14731.926340368283, 14737.557873263793, 14805.03767255129, 17020.0, 16073.0, 16165.43420980266, 16188.595285117877, 16193.83806161941, 16235.025898446102, 749.0935967479356, 906.9682561110362, 922.993936609096, 923.2429407885537, 930.0978051290238, 896.3770179725094, 901.1079031758545, 904.6155383961823, 904.674317245791, 907.1835348186652, 965.2133511188395, 965.2663975378728, 965.3676841668719, 965.6378857928277, 966.618185816602, 782.4249176855006, 947.4315410753561, 957.6360982826482, 957.683964291782, 967.4533888353093, 688.8897776355809, 693.143967200507, 693.7398475571661, 700.6951975890504, 702.0241863809309, 14999.475018374305, 15052.623684407868, 15068.698626027528, 15078.849211507853, 15083.245837708071, 13935.233562154077, 14168.645783855383, 14249.78625320621, 14257.215853128073, 14514.491992780202, 11739.941300293529, 11881.40592970348, 11917.165798394115, 12077.57728479499, 12233.69415764613, 4671.159191345557, 4746.311784791186, 4746.430428348585, 4756.619470442356, 4833.854984350475, 56216.43783562194, 56808.0, 56821.71589142028, 56907.14639280414, 56990.43009569934, 11038.724031899106, 11298.09615230796, 11317.207795454404, 11822.822657660143, 12018.819717704242, 20025.799742002684, 20169.0, 20182.798172018385, 20212.89893550523, 20238.797612023693, 8577.4424662398, 8862.0, 8863.157999989991, 8909.287257019423, 8911.0, 4933.777979990838, 5013.423456302499, 5029.64792464524, 5097.108006098918, 5202.0, 3509.280597477511, 3568.6966607838626, 3570.946435803465, 3576.1774791798034, 3579.552555930509, 610.4536439886366, 612.9233845769279, 613.4172536090732, 615.3815415507387, 615.8829822333743, 631.2204427531994, 697.5814511293285, 748.8364692310661, 770.9845803083907, 775.6005657086492, 9592.184664303473, 9615.759606009766, 9660.661876834418, 9669.661561845302, 9712.417254964725, 742.7623160588668, 768.5427170833345, 774.0658252907696, 787.2206515549565, 807.8868958345719, 4524.253498172765, 4544.091181763661, 4599.356090147382, 4619.792109355087, 4687.671862969628, 63047.684761575896, 63738.36261637417, 64418.0, 64425.0, 70745.64627176832, 55032.449675503536, 55604.0, 55638.44361556414, 55891.0, 57645.0, 50636.493635063176, 51078.0, 51262.231066534034, 51368.0, 51876.22185667218, 9549.379290346105, 9743.415395076318, 9798.951005244928, 9859.112679858847, 9926.255530835071, 37566.624333756314, 38237.61762382452, 38361.616383835804, 39973.60026399699, 39976.200475990896, 43741.0, 44005.77997110122, 47263.52736472729, 49638.75180624074, 50126.24810627916, 12804.935975320064, 12845.229286242855, 12955.870441295467, 13041.673958151123, 13119.344032798132, 13346.466141354236, 13433.26117063571, 14082.014259001771, 14339.856601433852, 15306.693866122838, 13152.89340709235, 13891.374888129856, 14130.576082717535, 14161.645958851112, 14649.487267945571, 12855.228686278853, 13162.0, 13749.587512374645, 13910.0, 14049.578512644637, 11858.644240672793, 12078.758424831278, 12272.202306850026, 12513.311767852856, 12516.436760345989, 11365.0, 11458.94270528642, 11745.823812642988, 11781.823272651089, 11977.401129943293, 11513.357846800807, 11582.36297003673, 11620.825687614524, 11770.882291176978, 11849.289042657469], "value": 7227.013389559244, "unit": "score"}], "name": "dromaeo_css", "value": 7379.220428569324, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 106.0, 110.0, 111.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 126.0, 155.0, 173.0, 126.0, 157.0, 148.0, 129.0, 181.0, 125.0], "value": 147.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 159.0, 162.0, 161.0, 160.0, 166.0, 160.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 172.0, 74.0, 76.0, 77.0, 76.0, 159.0, 75.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 152.0, 93.0, 91.0, 91.0, 153.0, 91.0, 91.0, 157.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 145.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 53.0, 53.0, 54.0, 54.0, 55.0, 78.0, 52.0, 53.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 57.0, 57.0, 58.0, 58.0, 57.0, 58.0, 57.0], "value": 57.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 75.0, 73.0, 73.0, 75.0, 74.0, 80.0, 75.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 116.0, 115.0, 115.0, 117.0, 115.0, 116.0, 134.0, 129.0, 116.0], "value": 119.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 164.0, 163.0, 160.0, 161.0, 164.0, 161.0, 167.0, 160.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 70.0, 65.0, 65.0, 66.0, 66.0, 67.0, 67.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1519.2000000000003, "alertThreshold": 2.0}]} 16:11:42 INFO - Return code: 0 16:11:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:11:42 ERROR - # TBPL SUCCESS # 16:11:42 INFO - Running post-action listener: _resource_record_post_action 16:11:42 INFO - Running post-run listener: _resource_record_post_run 16:11:43 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 12288; Write bytes: 463724544; Read time: 80; Write time: 817620 16:11:43 INFO - install - Wall time: 14s; CPU: 19.0%; Read bytes: 0; Write bytes: 229859328; Read time: 0; Write time: 584352 16:11:43 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 12288; Write bytes: 221851648; Read time: 80; Write time: 231744 16:11:43 INFO - Running post-run listener: _upload_blobber_files 16:11:43 INFO - Blob upload gear active. 16:11:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:11:43 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 16:11:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:11:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:11:44 INFO - (blobuploader) - INFO - Open directory for files ... 16:11:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:11:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:11:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:45 INFO - (blobuploader) - INFO - Done attempting. 16:11:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:11:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:11:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:45 INFO - (blobuploader) - INFO - Done attempting. 16:11:45 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:45 INFO - Return code: 0 16:11:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:11:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/952739d8d4be1c61c31ea905d57a803a19f5ba845ac1a3abbcc72d00b5df5652ec67b1e04b7c71172d564598565e7573078417139ca7f85825a4dd268f26b2f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b56e559cc976a8feec665c33537becdb91f6af9fa07b7b072d37da4b4866f838271a9de725747b4b27640b1127a2ceaee152d237283c7e4fde5b2a2eafd2a6f8"} 16:11:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:11:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:11:45 INFO - Contents: 16:11:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/952739d8d4be1c61c31ea905d57a803a19f5ba845ac1a3abbcc72d00b5df5652ec67b1e04b7c71172d564598565e7573078417139ca7f85825a4dd268f26b2f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b56e559cc976a8feec665c33537becdb91f6af9fa07b7b072d37da4b4866f838271a9de725747b4b27640b1127a2ceaee152d237283c7e4fde5b2a2eafd2a6f8"} 16:11:45 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:45 INFO - Copying logs to upload dir... 16:11:45 INFO - mkdir: /builds/slave/test/build/upload/logs 16:11:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.843456 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-29 16:11:45.749162) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 16:11:45.753004) ========= 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=af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/952739d8d4be1c61c31ea905d57a803a19f5ba845ac1a3abbcc72d00b5df5652ec67b1e04b7c71172d564598565e7573078417139ca7f85825a4dd268f26b2f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b56e559cc976a8feec665c33537becdb91f6af9fa07b7b072d37da4b4866f838271a9de725747b4b27640b1127a2ceaee152d237283c7e4fde5b2a2eafd2a6f8"} build_url:https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011390 build_url: 'https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/952739d8d4be1c61c31ea905d57a803a19f5ba845ac1a3abbcc72d00b5df5652ec67b1e04b7c71172d564598565e7573078417139ca7f85825a4dd268f26b2f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b56e559cc976a8feec665c33537becdb91f6af9fa07b7b072d37da4b4866f838271a9de725747b4b27640b1127a2ceaee152d237283c7e4fde5b2a2eafd2a6f8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 16:11:45.779559) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 16:11:45.779963) ========= 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=af724c981e2a0f424dbabf99000001e7-1467239788.650570-1351316801 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 16:11:45.863466) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 16:11:45.863805) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 16:11:45.864100) ========= ========= Total master_lag: 0.18 =========