builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1461501932.86 results: success (0) buildid: 20160424030601 builduid: 6c665d98c5ae4206b8a1aabef46f1129 revision: ab8a76ac7b34db20dd3c220c9846826334f3efdc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:32.858251) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:32.858613) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:32.858890) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:32.919569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:32.919838) ========= 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=32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-24 05:45:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-04-24 05:45:33 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105394 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:33.039604) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:33.039872) ========= 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=32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021164 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:33.089247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:33.089535) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ab8a76ac7b34db20dd3c220c9846826334f3efdc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ab8a76ac7b34db20dd3c220c9846826334f3efdc --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=32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-24 05:45:33,987 truncating revision to first 12 chars 2016-04-24 05:45:33,987 Setting DEBUG logging. 2016-04-24 05:45:33,987 attempt 1/10 2016-04-24 05:45:33,987 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ab8a76ac7b34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-24 05:45:34,215 unpacking tar archive at: mozilla-central-ab8a76ac7b34/testing/mozharness/ program finished with exit code 0 elapsedTime=0.513428 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:33.615026) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:33.615286) ========= script_repo_revision: ab8a76ac7b34db20dd3c220c9846826334f3efdc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:33.615639) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:33.615891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 05:45:33.625762) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-24 05:45:33.626033) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:45:34 INFO - MultiFileLogger online at 20160424 05:45:34 in /builds/slave/test 05:45:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:45:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:45:34 INFO - {'append_to_log': False, 05:45:34 INFO - 'base_work_dir': '/builds/slave/test', 05:45:34 INFO - 'blob_upload_branch': 'Firefox', 05:45:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:45:34 INFO - 'branch': 'Firefox', 05:45:34 INFO - 'buildbot_json_path': 'buildprops.json', 05:45:34 INFO - 'config_files': ('talos/linux_config.py',), 05:45:34 INFO - 'default_actions': ('clobber', 05:45:34 INFO - 'read-buildbot-config', 05:45:34 INFO - 'download-and-extract', 05:45:34 INFO - 'populate-webroot', 05:45:34 INFO - 'create-virtualenv', 05:45:34 INFO - 'install', 05:45:34 INFO - 'run-tests'), 05:45:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:45:34 INFO - 'download_minidump_stackwalk': True, 05:45:34 INFO - 'download_symbols': 'ondemand', 05:45:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:45:34 INFO - 'tooltool.py': '/tools/tooltool.py', 05:45:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:45:34 INFO - '/tools/misc-python/virtualenv.py')}, 05:45:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:45:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:45:34 INFO - 'installer_path': 'installer.exe', 05:45:34 INFO - 'log_level': 'info', 05:45:34 INFO - 'log_name': 'talos', 05:45:34 INFO - 'log_to_console': True, 05:45:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:45:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:45:34 INFO - 'opt_config_files': (), 05:45:34 INFO - 'pip_index': False, 05:45:34 INFO - 'sps_profile': False, 05:45:34 INFO - 'sps_profile_interval': 0, 05:45:34 INFO - 'suite': 'dromaeojs', 05:45:34 INFO - 'system_bits': '32', 05:45:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:45:34 INFO - 'title': 'talos-linux64-ix-008', 05:45:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:45:34 INFO - 'use_talos_json': True, 05:45:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:45:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:45:34 INFO - 'work_dir': 'build'} 05:45:34 INFO - ##### 05:45:34 INFO - ##### Running clobber step. 05:45:34 INFO - ##### 05:45:34 INFO - Running pre-action listener: _resource_record_pre_action 05:45:34 INFO - Running main action method: clobber 05:45:34 INFO - rmtree: /builds/slave/test/build 05:45:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:45:35 INFO - Running post-action listener: _resource_record_post_action 05:45:35 INFO - ##### 05:45:35 INFO - ##### Running read-buildbot-config step. 05:45:35 INFO - ##### 05:45:35 INFO - Running pre-action listener: _resource_record_pre_action 05:45:35 INFO - Running main action method: read_buildbot_config 05:45:35 INFO - Using buildbot properties: 05:45:35 INFO - { 05:45:35 INFO - "project": "", 05:45:35 INFO - "product": "firefox", 05:45:35 INFO - "script_repo_revision": "production", 05:45:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:45:35 INFO - "repository": "", 05:45:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:45:35 INFO - "buildid": "20160424030601", 05:45:35 INFO - "stage_platform": "linux64-pgo", 05:45:35 INFO - "basedir": "/builds/slave/test", 05:45:35 INFO - "nightly_build": "True", 05:45:35 INFO - "buildnumber": 417, 05:45:35 INFO - "slavename": "talos-linux64-ix-008", 05:45:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:45:35 INFO - "platform": "ubuntu64_hw", 05:45:35 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:45:35 INFO - "branch": "mozilla-central", 05:45:35 INFO - "repo_path": "mozilla-central", 05:45:35 INFO - "revision": "ab8a76ac7b34db20dd3c220c9846826334f3efdc", 05:45:35 INFO - "pgo_build": "True", 05:45:35 INFO - "builduid": "6c665d98c5ae4206b8a1aabef46f1129", 05:45:35 INFO - "slavebuilddir": "test" 05:45:35 INFO - } 05:45:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:45:35 INFO - Running post-action listener: _resource_record_post_action 05:45:35 INFO - ##### 05:45:35 INFO - ##### Running download-and-extract step. 05:45:35 INFO - ##### 05:45:35 INFO - Running pre-action listener: _resource_record_pre_action 05:45:35 INFO - Running main action method: download_and_extract 05:45:35 INFO - mkdir: /builds/slave/test/build/tests 05:45: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')]} 05:45:35 INFO - https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:45:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:45:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:45:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:45:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:45:47 INFO - Downloaded 1361 bytes. 05:45:47 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:45:47 INFO - Using the following test package requirements: 05:45:47 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:47 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:45:47 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:45:47 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:47 INFO - u'jsshell-linux-x86_64.zip'], 05:45:47 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:45:47 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:47 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:45:47 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:45:47 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:45:47 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:45:47 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:47 INFO - https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:45:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:45:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:45:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:45:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:45:56 INFO - Downloaded 23857858 bytes. 05:45:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:45:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:45:58 INFO - Return code: 0 05:45:58 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:58 INFO - https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:45:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:45:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:45:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:45:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:45:59 INFO - Downloaded 23857858 bytes. 05:45:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:45:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:46:01 INFO - Return code: 0 05:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:01 INFO - https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:46:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:46:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:46:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:46:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:46:03 INFO - Downloaded 10840145 bytes. 05:46:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:46:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:46:03 INFO - Return code: 0 05:46: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')]} 05:46:03 INFO - https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:46:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:46:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:46:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:46:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:46:05 INFO - Downloaded 58366061 bytes. 05:46:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:46:05 INFO - mkdir: /builds/slave/test/properties 05:46:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:46:05 INFO - Writing to file /builds/slave/test/properties/build_url 05:46:05 INFO - Contents: 05:46:05 INFO - build_url:https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:46:06 INFO - Running post-action listener: _resource_record_post_action 05:46:06 INFO - Running post-action listener: set_extra_try_arguments 05:46:06 INFO - ##### 05:46:06 INFO - ##### Running populate-webroot step. 05:46:06 INFO - ##### 05:46:06 INFO - Running pre-action listener: _resource_record_pre_action 05:46:06 INFO - Running main action method: populate_webroot 05:46:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:46:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:46:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:46:06 INFO - '--tppagecycles', 05:46:06 INFO - '7'], 05:46:06 INFO - 'tests': ['tsvgm']}}, 05:46:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:46:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:46:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:46:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:46:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:46:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:46:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:06 INFO - 'talos_options': ['--disable-e10s'], 05:46:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:06 INFO - 'talos_options': ['--disable-e10s'], 05:46:06 INFO - 'tests': ['damp', 'tps']}, 05:46:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:06 INFO - 'tests': ['damp', 'tps']}, 05:46:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:46:06 INFO - 'tests': ['dromaeo_dom']}, 05:46:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:46:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:46:06 INFO - 'tests': ['a11yr', 05:46:06 INFO - 'ts_paint', 05:46:06 INFO - 'tpaint', 05:46:06 INFO - 'sessionrestore', 05:46:06 INFO - 'sessionrestore_no_auto_restore', 05:46:06 INFO - 'tabpaint']}, 05:46:06 INFO - 'other-e10s': {'tests': ['a11yr', 05:46:06 INFO - 'ts_paint', 05:46:06 INFO - 'tpaint', 05:46:06 INFO - 'sessionrestore', 05:46:06 INFO - 'sessionrestore_no_auto_restore', 05:46:06 INFO - 'tabpaint']}, 05:46:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:46:06 INFO - 'ts_paint', 05:46:06 INFO - 'tpaint', 05:46:06 INFO - 'sessionrestore', 05:46:06 INFO - 'sessionrestore_no_auto_restore', 05:46:06 INFO - 'tabpaint']}, 05:46:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:46:06 INFO - 'ts_paint', 05:46:06 INFO - 'tpaint', 05:46:06 INFO - 'sessionrestore', 05:46:06 INFO - 'sessionrestore_no_auto_restore', 05:46:06 INFO - 'tabpaint']}, 05:46:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:46:06 INFO - 'tests': ['a11yr', 05:46:06 INFO - 'ts_paint', 05:46:06 INFO - 'tpaint', 05:46:06 INFO - 'sessionrestore', 05:46:06 INFO - 'sessionrestore_no_auto_restore', 05:46:06 INFO - 'tabpaint']}, 05:46:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:46:06 INFO - 'tests': ['a11yr', 05:46:06 INFO - 'ts_paint', 05:46:06 INFO - 'tpaint', 05:46:06 INFO - 'sessionrestore', 05:46:06 INFO - 'sessionrestore_no_auto_restore', 05:46:06 INFO - 'tabpaint']}, 05:46:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:46:06 INFO - 'tests': ['tsvgx', 05:46:06 INFO - 'tsvgr_opacity', 05:46:06 INFO - 'tart', 05:46:06 INFO - 'tscrollx', 05:46:06 INFO - 'cart']}, 05:46:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:46:06 INFO - 'tsvgr_opacity', 05:46:06 INFO - 'tart', 05:46:06 INFO - 'tscrollx', 05:46:06 INFO - 'cart']}, 05:46:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:06 INFO - 'talos_options': ['--disable-e10s'], 05:46:06 INFO - 'tests': ['tp5o']}, 05:46:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:06 INFO - 'tests': ['tp5o']}, 05:46:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:06 INFO - 'talos_options': ['--disable-e10s', 05:46:06 INFO - '--xperf_path', 05:46:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:06 INFO - 'tests': ['tp5n']}, 05:46:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:06 INFO - 'talos_options': ['--xperf_path', 05:46:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:06 INFO - 'tests': ['tp5n']}}, 05:46:06 INFO - 'talos.zip': {'path': '', 05:46:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:46:06 INFO - Running post-action listener: _resource_record_post_action 05:46:06 INFO - ##### 05:46:06 INFO - ##### Running create-virtualenv step. 05:46:06 INFO - ##### 05:46:06 INFO - Running pre-action listener: _resource_record_pre_action 05:46:06 INFO - Running main action method: create_virtualenv 05:46:06 INFO - Creating virtualenv /builds/slave/test/build/venv 05:46:06 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 05:46:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:46:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:46:06 INFO - Using real prefix '/usr' 05:46:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:46:07 INFO - Installing distribute.............................................................................................................................................................................................done. 05:46:09 INFO - Installing pip.................done. 05:46:09 INFO - Return code: 0 05:46:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:46:09 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')]} 05:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:09 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')]} 05:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:09 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 0x7f99da642f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20619a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f0810>, '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 0x20f1710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1ba0>, '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': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', '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 05:46:09 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 05:46:09 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 05:46:09 INFO - Using env: {'DISPLAY': ':0', 05:46:09 INFO - 'HOME': '/home/cltbld', 05:46:09 INFO - 'LANG': 'en_US.UTF-8', 05:46:09 INFO - 'LANGUAGE': 'en_US:en', 05:46:09 INFO - 'LOGNAME': 'cltbld', 05:46:09 INFO - 'MAIL': '/var/mail/cltbld', 05:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:09 INFO - 'MOZ_NO_REMOTE': '1', 05:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:09 INFO - 'NO_EM_RESTART': '1', 05:46:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:09 INFO - 'PWD': '/builds/slave/test', 05:46:09 INFO - 'SHELL': '/bin/bash', 05:46:09 INFO - 'SHLVL': '1', 05:46:09 INFO - 'TERM': 'linux', 05:46:09 INFO - 'TMOUT': '86400', 05:46:09 INFO - 'USER': 'cltbld', 05:46:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', 05:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:09 INFO - '_': '/tools/buildbot/bin/python'} 05:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:09 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 05:46:09 INFO - Cleaning up... 05:46:09 INFO - Return code: 0 05:46:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:46:09 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')]} 05:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:09 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')]} 05:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:09 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 0x7f99da642f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20619a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f0810>, '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 0x20f1710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1ba0>, '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': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', '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 05:46:09 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 05:46:09 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 05:46:09 INFO - Using env: {'DISPLAY': ':0', 05:46:09 INFO - 'HOME': '/home/cltbld', 05:46:09 INFO - 'LANG': 'en_US.UTF-8', 05:46:09 INFO - 'LANGUAGE': 'en_US:en', 05:46:09 INFO - 'LOGNAME': 'cltbld', 05:46:09 INFO - 'MAIL': '/var/mail/cltbld', 05:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:09 INFO - 'MOZ_NO_REMOTE': '1', 05:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:09 INFO - 'NO_EM_RESTART': '1', 05:46:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:09 INFO - 'PWD': '/builds/slave/test', 05:46:09 INFO - 'SHELL': '/bin/bash', 05:46:09 INFO - 'SHLVL': '1', 05:46:09 INFO - 'TERM': 'linux', 05:46:09 INFO - 'TMOUT': '86400', 05:46:09 INFO - 'USER': 'cltbld', 05:46:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', 05:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:09 INFO - '_': '/tools/buildbot/bin/python'} 05:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:09 INFO - Downloading/unpacking psutil>=0.7.1 05:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:46:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:11 INFO - Installing collected packages: psutil 05:46:11 INFO - Running setup.py install for psutil 05:46:11 INFO - building 'psutil._psutil_linux' extension 05:46:11 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 05:46:11 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 05:46:11 INFO - building 'psutil._psutil_posix' extension 05:46:11 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 05:46:11 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 05:46:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:11 INFO - Successfully installed psutil 05:46:11 INFO - Cleaning up... 05:46:12 INFO - Return code: 0 05:46:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:46:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f99da642f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20619a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f0810>, '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 0x20f1710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1ba0>, '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': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', '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 05:46:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:46:12 INFO - Using env: {'DISPLAY': ':0', 05:46:12 INFO - 'HOME': '/home/cltbld', 05:46:12 INFO - 'LANG': 'en_US.UTF-8', 05:46:12 INFO - 'LANGUAGE': 'en_US:en', 05:46:12 INFO - 'LOGNAME': 'cltbld', 05:46:12 INFO - 'MAIL': '/var/mail/cltbld', 05:46:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:12 INFO - 'MOZ_NO_REMOTE': '1', 05:46:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:12 INFO - 'NO_EM_RESTART': '1', 05:46:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:12 INFO - 'PWD': '/builds/slave/test', 05:46:12 INFO - 'SHELL': '/bin/bash', 05:46:12 INFO - 'SHLVL': '1', 05:46:12 INFO - 'TERM': 'linux', 05:46:12 INFO - 'TMOUT': '86400', 05:46:12 INFO - 'USER': 'cltbld', 05:46:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', 05:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:12 INFO - '_': '/tools/buildbot/bin/python'} 05:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:46:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:46:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:46:14 INFO - Installing collected packages: mozsystemmonitor 05:46:14 INFO - Running setup.py install for mozsystemmonitor 05:46:14 INFO - Successfully installed mozsystemmonitor 05:46:14 INFO - Cleaning up... 05:46:14 INFO - Return code: 0 05:46:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f99da642f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20619a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f0810>, '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 0x20f1710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1ba0>, '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': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', '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 05:46:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:46:14 INFO - Using env: {'DISPLAY': ':0', 05:46:14 INFO - 'HOME': '/home/cltbld', 05:46:14 INFO - 'LANG': 'en_US.UTF-8', 05:46:14 INFO - 'LANGUAGE': 'en_US:en', 05:46:14 INFO - 'LOGNAME': 'cltbld', 05:46:14 INFO - 'MAIL': '/var/mail/cltbld', 05:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:14 INFO - 'MOZ_NO_REMOTE': '1', 05:46:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:14 INFO - 'NO_EM_RESTART': '1', 05:46:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:14 INFO - 'PWD': '/builds/slave/test', 05:46:14 INFO - 'SHELL': '/bin/bash', 05:46:14 INFO - 'SHLVL': '1', 05:46:14 INFO - 'TERM': 'linux', 05:46:14 INFO - 'TMOUT': '86400', 05:46:14 INFO - 'USER': 'cltbld', 05:46:14 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', 05:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:14 INFO - '_': '/tools/buildbot/bin/python'} 05:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:14 INFO - Downloading/unpacking blobuploader==1.2.4 05:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:16 INFO - Downloading blobuploader-1.2.4.tar.gz 05:46:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:46:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:46:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:17 INFO - Downloading docopt-0.6.1.tar.gz 05:46:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:46:17 INFO - Installing collected packages: blobuploader, requests, docopt 05:46:17 INFO - Running setup.py install for blobuploader 05:46:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:46:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:46:17 INFO - Running setup.py install for requests 05:46:17 INFO - Running setup.py install for docopt 05:46:17 INFO - Successfully installed blobuploader requests docopt 05:46:17 INFO - Cleaning up... 05:46:17 INFO - Return code: 0 05:46:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:17 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')]} 05:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:17 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')]} 05:46:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:17 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 0x7f99da642f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20619a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f0810>, '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 0x20f1710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1ba0>, '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': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', '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 05:46:17 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 05:46:17 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 05:46:17 INFO - Using env: {'DISPLAY': ':0', 05:46:17 INFO - 'HOME': '/home/cltbld', 05:46:17 INFO - 'LANG': 'en_US.UTF-8', 05:46:17 INFO - 'LANGUAGE': 'en_US:en', 05:46:17 INFO - 'LOGNAME': 'cltbld', 05:46:17 INFO - 'MAIL': '/var/mail/cltbld', 05:46:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:17 INFO - 'MOZ_NO_REMOTE': '1', 05:46:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:17 INFO - 'NO_EM_RESTART': '1', 05:46:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:17 INFO - 'PWD': '/builds/slave/test', 05:46:17 INFO - 'SHELL': '/bin/bash', 05:46:17 INFO - 'SHLVL': '1', 05:46:17 INFO - 'TERM': 'linux', 05:46:17 INFO - 'TMOUT': '86400', 05:46:17 INFO - 'USER': 'cltbld', 05:46:17 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', 05:46:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:17 INFO - '_': '/tools/buildbot/bin/python'} 05:46:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:18 INFO - Running setup.py (path:/tmp/pip-7_UYf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:18 INFO - Running setup.py (path:/tmp/pip-myrRMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:18 INFO - Running setup.py (path:/tmp/pip-AFjLAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:18 INFO - Running setup.py (path:/tmp/pip-lLRh3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:18 INFO - Running setup.py (path:/tmp/pip-USDigI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:18 INFO - Running setup.py (path:/tmp/pip-CIzE5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:18 INFO - Running setup.py (path:/tmp/pip-VfxcwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:18 INFO - Running setup.py (path:/tmp/pip-J0zBda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:18 INFO - Running setup.py (path:/tmp/pip-t5U_2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:18 INFO - Running setup.py (path:/tmp/pip-QTOKIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:18 INFO - Running setup.py (path:/tmp/pip-cLLUXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:18 INFO - Running setup.py (path:/tmp/pip-lP2Gjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:18 INFO - Running setup.py (path:/tmp/pip-EcSGl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:18 INFO - Running setup.py (path:/tmp/pip-IWjCiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:19 INFO - Running setup.py (path:/tmp/pip-fyvgMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:19 INFO - Running setup.py (path:/tmp/pip-kxAESm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:19 INFO - Running setup.py (path:/tmp/pip-TLdrL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:46:19 INFO - Running setup.py install for manifestparser 05:46:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:46:19 INFO - Running setup.py install for mozcrash 05:46:19 INFO - Running setup.py install for mozdebug 05:46:19 INFO - Running setup.py install for mozdevice 05:46:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:46:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:46:19 INFO - Running setup.py install for mozfile 05:46:19 INFO - Running setup.py install for mozhttpd 05:46:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:46:19 INFO - Running setup.py install for mozinfo 05:46:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:46:19 INFO - Running setup.py install for mozInstall 05:46:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:46:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:46:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:46:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:46:20 INFO - Running setup.py install for mozleak 05:46:20 INFO - Running setup.py install for mozlog 05:46:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:46:20 INFO - Running setup.py install for moznetwork 05:46:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:46:20 INFO - Running setup.py install for mozprocess 05:46:20 INFO - Running setup.py install for mozprofile 05:46:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:46:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:46:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:46:20 INFO - Running setup.py install for mozrunner 05:46:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:46:20 INFO - Running setup.py install for mozscreenshot 05:46:20 INFO - Running setup.py install for moztest 05:46:20 INFO - Running setup.py install for mozversion 05:46:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:46:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:46:21 INFO - Cleaning up... 05:46:21 INFO - Return code: 0 05:46:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:21 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')]} 05:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:21 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')]} 05:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:21 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 0x7f99da642f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20619a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f0810>, '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 0x20f1710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1ba0>, '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': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', '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 05:46:21 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 05:46:21 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 05:46:21 INFO - Using env: {'DISPLAY': ':0', 05:46:21 INFO - 'HOME': '/home/cltbld', 05:46:21 INFO - 'LANG': 'en_US.UTF-8', 05:46:21 INFO - 'LANGUAGE': 'en_US:en', 05:46:21 INFO - 'LOGNAME': 'cltbld', 05:46:21 INFO - 'MAIL': '/var/mail/cltbld', 05:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:21 INFO - 'MOZ_NO_REMOTE': '1', 05:46:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:21 INFO - 'NO_EM_RESTART': '1', 05:46:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:21 INFO - 'PWD': '/builds/slave/test', 05:46:21 INFO - 'SHELL': '/bin/bash', 05:46:21 INFO - 'SHLVL': '1', 05:46:21 INFO - 'TERM': 'linux', 05:46:21 INFO - 'TMOUT': '86400', 05:46:21 INFO - 'USER': 'cltbld', 05:46:21 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', 05:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:21 INFO - '_': '/tools/buildbot/bin/python'} 05:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:21 INFO - Running setup.py (path:/tmp/pip-3DcLHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:21 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)) 05:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:21 INFO - Running setup.py (path:/tmp/pip-EV5KUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:21 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)) 05:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:21 INFO - Running setup.py (path:/tmp/pip-jjpHZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:21 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)) 05:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:21 INFO - Running setup.py (path:/tmp/pip-MRWYUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:21 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)) 05:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:21 INFO - Running setup.py (path:/tmp/pip-PTjxLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:21 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)) 05:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:21 INFO - Running setup.py (path:/tmp/pip-mCfY5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:21 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)) 05:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:21 INFO - Running setup.py (path:/tmp/pip-Zqwamg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:21 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)) 05:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:21 INFO - Running setup.py (path:/tmp/pip-dTosj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:21 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)) 05:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:21 INFO - Running setup.py (path:/tmp/pip-whBdNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:21 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)) 05:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:21 INFO - Running setup.py (path:/tmp/pip-mdv497-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:21 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)) 05:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:21 INFO - Running setup.py (path:/tmp/pip-ZGmjxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:22 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)) 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:22 INFO - Running setup.py (path:/tmp/pip-WsaOUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:22 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)) 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:22 INFO - Running setup.py (path:/tmp/pip-Un8MK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:22 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)) 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:22 INFO - Running setup.py (path:/tmp/pip-0RhH08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:22 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)) 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:22 INFO - Running setup.py (path:/tmp/pip-yaKPNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:22 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)) 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:22 INFO - Running setup.py (path:/tmp/pip-GOBF9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:22 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)) 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:22 INFO - Running setup.py (path:/tmp/pip-4CywUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:22 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)) 05:46:22 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)) 05:46:22 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)) 05:46:22 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)) 05:46:22 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)) 05:46:22 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)) 05:46:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:46:22 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 05:46:22 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 05:46:22 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 05:46:22 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 05:46:22 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 05:46:22 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 05:46:24 INFO - Downloading blessings-1.6.tar.gz 05:46:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:46:24 INFO - Installing collected packages: blessings 05:46:24 INFO - Running setup.py install for blessings 05:46:24 INFO - Successfully installed blessings 05:46:24 INFO - Cleaning up... 05:46:24 INFO - Return code: 0 05:46:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:46:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:24 INFO - Reading from file tmpfile_stdout 05:46:24 INFO - Current package versions: 05:46:24 INFO - argparse == 1.2.1 05:46:24 INFO - blessings == 1.6 05:46:24 INFO - blobuploader == 1.2.4 05:46:24 INFO - docopt == 0.6.1 05:46:24 INFO - manifestparser == 1.1 05:46:24 INFO - mozInstall == 1.12 05:46:24 INFO - mozcrash == 0.17 05:46:24 INFO - mozdebug == 0.1 05:46:24 INFO - mozdevice == 0.48 05:46:24 INFO - mozfile == 1.2 05:46:24 INFO - mozhttpd == 0.7 05:46:24 INFO - mozinfo == 0.9 05:46:24 INFO - mozleak == 0.1 05:46:24 INFO - mozlog == 3.1 05:46:24 INFO - moznetwork == 0.27 05:46:24 INFO - mozprocess == 0.22 05:46:24 INFO - mozprofile == 0.28 05:46:24 INFO - mozrunner == 6.11 05:46:24 INFO - mozscreenshot == 0.1 05:46:24 INFO - mozsystemmonitor == 0.0 05:46:24 INFO - moztest == 0.7 05:46:24 INFO - mozversion == 1.4 05:46:24 INFO - psutil == 3.1.1 05:46:24 INFO - requests == 1.2.3 05:46:24 INFO - wsgiref == 0.1.2 05:46:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:24 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')]} 05:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:24 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')]} 05:46:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:24 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 0x7f99da642f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20619a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f0810>, '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 0x20f1710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1ba0>, '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': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', '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 05:46:24 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 05:46:24 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 05:46:24 INFO - Using env: {'DISPLAY': ':0', 05:46:24 INFO - 'HOME': '/home/cltbld', 05:46:24 INFO - 'LANG': 'en_US.UTF-8', 05:46:24 INFO - 'LANGUAGE': 'en_US:en', 05:46:24 INFO - 'LOGNAME': 'cltbld', 05:46:24 INFO - 'MAIL': '/var/mail/cltbld', 05:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:24 INFO - 'MOZ_NO_REMOTE': '1', 05:46:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:24 INFO - 'NO_EM_RESTART': '1', 05:46:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:24 INFO - 'PWD': '/builds/slave/test', 05:46:24 INFO - 'SHELL': '/bin/bash', 05:46:24 INFO - 'SHLVL': '1', 05:46:24 INFO - 'TERM': 'linux', 05:46:24 INFO - 'TMOUT': '86400', 05:46:24 INFO - 'USER': 'cltbld', 05:46:24 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', 05:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:24 INFO - '_': '/tools/buildbot/bin/python'} 05:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:24 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)) 05:46:24 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)) 05:46:24 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)) 05:46:24 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)) 05:46:24 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)) 05:46:24 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)) 05:46:24 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)) 05:46:24 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)) 05:46:24 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)) 05:46:24 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)) 05:46:24 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)) 05:46:24 INFO - Cleaning up... 05:46:25 INFO - Return code: 0 05:46:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:25 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 0x7f99da642f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20619a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f0810>, '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 0x20f1710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1ba0>, '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': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', '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 05:46:25 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 05:46:25 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 05:46:25 INFO - Using env: {'DISPLAY': ':0', 05:46:25 INFO - 'HOME': '/home/cltbld', 05:46:25 INFO - 'LANG': 'en_US.UTF-8', 05:46:25 INFO - 'LANGUAGE': 'en_US:en', 05:46:25 INFO - 'LOGNAME': 'cltbld', 05:46:25 INFO - 'MAIL': '/var/mail/cltbld', 05:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:25 INFO - 'MOZ_NO_REMOTE': '1', 05:46:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:25 INFO - 'NO_EM_RESTART': '1', 05:46:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:25 INFO - 'PWD': '/builds/slave/test', 05:46:25 INFO - 'SHELL': '/bin/bash', 05:46:25 INFO - 'SHLVL': '1', 05:46:25 INFO - 'TERM': 'linux', 05:46:25 INFO - 'TMOUT': '86400', 05:46:25 INFO - 'USER': 'cltbld', 05:46:25 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', 05:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:25 INFO - '_': '/tools/buildbot/bin/python'} 05:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:25 INFO - Downloading/unpacking jsonschema 05:46:25 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 05:46:25 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 05:46:25 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 05:46:25 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 05:46:25 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 05:46:25 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 05:46:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:46:27 INFO - Downloading/unpacking functools32 (from jsonschema) 05:46:27 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 05:46:27 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 05:46:27 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 05:46:27 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 05:46:27 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 05:46:27 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 05:46:27 INFO - Downloading functools32-3.2.3-2.tar.gz 05:46:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:46:27 INFO - warning: no files found matching '*.txt' 05:46:27 INFO - no previously-included directories found matching 'build' 05:46:27 INFO - no previously-included directories found matching 'dist' 05:46:27 INFO - no previously-included directories found matching '.git*' 05:46:27 INFO - Installing collected packages: jsonschema, functools32 05:46:27 INFO - Running setup.py install for functools32 05:46:27 INFO - warning: no files found matching '*.txt' 05:46:27 INFO - no previously-included directories found matching 'build' 05:46:27 INFO - no previously-included directories found matching 'dist' 05:46:27 INFO - no previously-included directories found matching '.git*' 05:46:27 INFO - Successfully installed jsonschema functools32 05:46:27 INFO - Cleaning up... 05:46:27 INFO - Return code: 0 05:46:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:46:27 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')]} 05:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:27 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')]} 05:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:27 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 0x7f99da642f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20619a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f0810>, '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 0x20f1710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1ba0>, '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': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', '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 05:46:27 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 05:46:27 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 05:46:27 INFO - Using env: {'DISPLAY': ':0', 05:46:27 INFO - 'HOME': '/home/cltbld', 05:46:27 INFO - 'LANG': 'en_US.UTF-8', 05:46:27 INFO - 'LANGUAGE': 'en_US:en', 05:46:27 INFO - 'LOGNAME': 'cltbld', 05:46:27 INFO - 'MAIL': '/var/mail/cltbld', 05:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:27 INFO - 'MOZ_NO_REMOTE': '1', 05:46:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:27 INFO - 'NO_EM_RESTART': '1', 05:46:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:27 INFO - 'PWD': '/builds/slave/test', 05:46:27 INFO - 'SHELL': '/bin/bash', 05:46:27 INFO - 'SHLVL': '1', 05:46:27 INFO - 'TERM': 'linux', 05:46:27 INFO - 'TMOUT': '86400', 05:46:27 INFO - 'USER': 'cltbld', 05:46:27 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', 05:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:27 INFO - '_': '/tools/buildbot/bin/python'} 05:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:27 INFO - Downloading/unpacking flake8 05:46:27 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 05:46:27 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 05:46:27 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 05:46:27 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 05:46:27 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 05:46:27 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 05:46:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:46:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:46:29 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 05:46:29 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 05:46:29 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 05:46:29 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 05:46:29 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 05:46:29 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 05:46:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:46:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:46:29 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 05:46:29 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 05:46:29 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 05:46:29 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 05:46:29 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 05:46:29 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 05:46:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:46:30 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 05:46:30 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 05:46:30 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 05:46:30 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 05:46:30 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 05:46:30 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 05:46:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:46:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:46:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:46:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:46:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:46:30 INFO - no previously-included directories found matching 'docs/_build' 05:46:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:46:30 INFO - Running setup.py install for pep8 05:46:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:46:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:46:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:46:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:46:30 INFO - no previously-included directories found matching 'docs/_build' 05:46:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:46:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:46:30 INFO - Cleaning up... 05:46:30 INFO - Return code: 0 05:46:30 INFO - Running post-action listener: _resource_record_post_action 05:46:30 INFO - Running post-action listener: _start_resource_monitoring 05:46:30 INFO - Starting resource monitoring. 05:46:30 INFO - ##### 05:46:30 INFO - ##### Running install step. 05:46:30 INFO - ##### 05:46:30 INFO - Running pre-action listener: _resource_record_pre_action 05:46:30 INFO - Running main action method: install 05:46:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:30 INFO - Reading from file tmpfile_stdout 05:46:30 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:46:30 INFO - Reading from file tmpfile_stdout 05:46:30 INFO - Output received: 05:46:30 INFO - Usage: mozinstall [options] installer 05:46:30 INFO - Options: 05:46:30 INFO - -h, --help show this help message and exit 05:46:30 INFO - -d DEST, --destination=DEST 05:46:30 INFO - Directory to install application into. [default: 05:46:30 INFO - "/builds/slave/test"] 05:46:30 INFO - --app=APP Application being installed. [default: firefox] 05:46:30 INFO - mkdir: /builds/slave/test/build/application 05:46:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:46:47 INFO - Reading from file tmpfile_stdout 05:46:47 INFO - Output received: 05:46:47 INFO - /builds/slave/test/build/application/firefox/firefox 05:46:47 INFO - Running post-action listener: _resource_record_post_action 05:46:47 INFO - ##### 05:46:47 INFO - ##### Running run-tests step. 05:46:47 INFO - ##### 05:46:47 INFO - Running pre-action listener: _resource_record_pre_action 05:46:47 INFO - Running main action method: run_tests 05:46:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:46:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:46:47 INFO - Python 2.7.3 05:46:47 INFO - Return code: 0 05:46:47 INFO - grabbing minidump binary from tooltool 05:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:47 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 0x20f0810>, '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 0x20f1710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:46:47 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 05:46:47 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 05:46:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:46:47 INFO - Return code: 0 05:46:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:46:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:46:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:46:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:46:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:46:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:46:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:46:48 INFO - Return code: 0 05:46:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 05:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 05:46:48 INFO - Using env: {'DISPLAY': ':0', 05:46:48 INFO - 'HOME': '/home/cltbld', 05:46:48 INFO - 'LANG': 'en_US.UTF-8', 05:46:48 INFO - 'LANGUAGE': 'en_US:en', 05:46:48 INFO - 'LOGNAME': 'cltbld', 05:46:48 INFO - 'MAIL': '/var/mail/cltbld', 05:46:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:46:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:48 INFO - 'MOZ_NO_REMOTE': '1', 05:46:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:48 INFO - 'NO_EM_RESTART': '1', 05:46:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:48 INFO - 'PWD': '/builds/slave/test', 05:46:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:46:48 INFO - 'SHELL': '/bin/bash', 05:46:48 INFO - 'SHLVL': '1', 05:46:48 INFO - 'TERM': 'linux', 05:46:48 INFO - 'TMOUT': '86400', 05:46:48 INFO - 'USER': 'cltbld', 05:46:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147', 05:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:48 INFO - '_': '/tools/buildbot/bin/python'} 05:46:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 05:46:48 INFO - mozversion application_buildid: 20160424030601 05:46:48 INFO - mozversion application_changeset: ab8a76ac7b34db20dd3c220c9846826334f3efdc 05:46:48 INFO - mozversion application_display_name: Nightly 05:46:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:46:48 INFO - mozversion application_name: Firefox 05:46:48 INFO - mozversion application_remotingname: firefox 05:46:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:46:48 INFO - mozversion application_vendor: Mozilla 05:46:48 INFO - mozversion application_version: 48.0a1 05:46:48 INFO - mozversion platform_buildid: 20160424030601 05:46:48 INFO - mozversion platform_changeset: ab8a76ac7b34db20dd3c220c9846826334f3efdc 05:46:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:46:48 INFO - mozversion platform_version: 48.0a1 05:46:48 INFO - using testdate: 1461502008 05:46:48 INFO - actual date: 1461502008 05:46:48 INFO - starting webserver on 'localhost:46171' 05:46:48 INFO - SUITE-START | Running 2 tests 05:46:48 INFO - TEST-START | dromaeo_css 05:46:48 INFO - operating with platform_type : linux_ 05:46:48 INFO - Initialising browser for dromaeo_css test... 05:46:48 INFO - TEST-INFO | started process 25537 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_7qd1F/profile http://localhost:46171/getInfo.html) 05:46:52 INFO - PROCESS | 25537 | __metrics Screen width/height:1600/1200 05:46:52 INFO - PROCESS | 25537 | colorDepth:24 05:46:52 INFO - PROCESS | 25537 | Browser inner width/height: 1024/697 05:46:52 INFO - PROCESS | 25537 | __metrics 05:46:53 ERROR - PROCESS | 25537 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:46:54 INFO - TEST-INFO | 25537: exit 0 05:46:54 INFO - Browser initialized. 05:46:54 INFO - Running cycle 1/1 for dromaeo_css test... 05:46:54 INFO - TEST-INFO | started process 25618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_7qd1F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:06 INFO - PROCESS | 25618 | RSS: Main: 153604096 05:47:06 INFO - PROCESS | 25618 | 05:47:57 INFO - PROCESS | 25618 | 1461502077322 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] 05:50:04 INFO - PROCESS | 25618 | Cycle 1(1): loaded http://localhost:46171/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46171/tests/dromaeo/cssquery-ext.html) 05:50:06 INFO - PROCESS | 25618 | RSS: Main: 259235840 05:50:06 INFO - PROCESS | 25618 | 05:53:08 INFO - PROCESS | 25618 | Cycle 1(1): loaded http://localhost:46171/tests/dromaeo/cssquery-ext.html (next: http://localhost:46171/tests/dromaeo/cssquery-jquery.html) 05:53:08 INFO - PROCESS | 25618 | RSS: Main: 245264384 05:53:08 INFO - PROCESS | 25618 | 05:56:10 INFO - PROCESS | 25618 | Cycle 1(1): loaded http://localhost:46171/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46171/tests/dromaeo/cssquery-mootools.html) 05:56:11 INFO - PROCESS | 25618 | RSS: Main: 238092288 05:56:11 INFO - PROCESS | 25618 | 05:59:13 INFO - PROCESS | 25618 | Cycle 1(1): loaded http://localhost:46171/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46171/tests/dromaeo/cssquery-prototype.html) 05:59:13 INFO - PROCESS | 25618 | RSS: Main: 231604224 05:59:13 INFO - PROCESS | 25618 | 06:02:16 INFO - PROCESS | 25618 | Cycle 1(1): loaded http://localhost:46171/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46171/tests/dromaeo/cssquery-yui.html) 06:02:16 INFO - PROCESS | 25618 | RSS: Main: 226291712 06:02:16 INFO - PROCESS | 25618 | 06:05:19 INFO - PROCESS | 25618 | Cycle 1(1): loaded http://localhost:46171/tests/dromaeo/cssquery-yui.html (next: http://localhost:46171/tests/dromaeo/cssquery-dojo.html) 06:05:19 INFO - PROCESS | 25618 | RSS: Main: 279724032 06:05:19 INFO - PROCESS | 25618 | 06:05:19 INFO - PROCESS | 25618 | __start_tp_report 06:05:19 INFO - PROCESS | 25618 | _x_x_mozilla_page_load 06:05:19 INFO - PROCESS | 25618 | _x_x_mozilla_page_load_details 06:05:19 INFO - PROCESS | 25618 | |i|pagename|runs| 06:05:19 INFO - PROCESS | 25618 | |0;dojo.html;3114.4394009078364;3160.367926414715;3191.1543440988125;3203.1831882869865;3228.5480032795413;5121.6414850960355;5211.348581427322;5329;5339.199120131977;5406.783728650849;5369.275147855048;5373.194020896867;5387.946120538793;5426.538744206738;5452.100403433429;4757.167495688258;4773.76131193439;4776.546228108324;4784.162771514971;4962.478939711333;4883.902321953558;4897.902041959159;4928.704277743347;4942.728149951751;4958.157113290731;4750.216214324632;4849.854504364875;4863.124637565237;4898.387701537308;4908.141075311806;4854.587360074398;4880.6095512358925;4886.780094895703;4903.607711383081;4915.5330243626795;4715.811367545294;4801.087793319258;4846.684965477232;4864.537868902484;4896.583790377822;5309.044372013036;5314.468553144693;5322.33470816148;5337.653052551572;5367.329083864517;5686.744096515667;5693.089105743061;5717.742701578439;5721.914171287434;5722.885542289173;5617.775288988436;5756.597038207327;5761.337446193699;5768.740406681667;5824;5402.9729851350885;5406.02691515531;5410.810621628224;5411.864703382447;5413.593980451482;5851.824445266649;5879.617824841372;5880.206172166702;5884.852878678067;5890.410958904161;5480.534154596904;5606.859828504238;5650.491455768918;5692.31692196939;5708.429157084258;5680.289963754531;5696.857578560569;5699.629524081004;5702.144678298206;5707.514861236841;5625.212470254168;5626.578006649435;5632.098864181793;5632.295963004624;5635.943640563624;5523.1991361253195;5696.8860622787315;5734.99637563433;5744.281964754406;5786.681732504752;4297.269464191095;4301.182775272689;4301.78491075445;4308.67684923632;4337.457817772778;3790.5261842269715;3862.7682339059747;3863.9613603864163;3881.4565960765517;3919.451276821247;5330.333708286465;5362.839114826484;5368.812091576776;5407.107827208545;5410;5697.259356283656;5702.6863522506665;5722.828315150552;5727.6849773262875;5740.741666625012;5282.550983166397;5285.762140703678;5378.354597448253;5387.326584176978;5430.538404235605;4904.141775189399;4921.114199444134;4926.827561035347;4932.926006109911;4973.055119527278;5902.498287645598;5906.704664766745;5909.379515150933;5916;5920.970395147997;5598.412166722435;5710.628809127394;5748.252727145445;5799.130130480462;5804.883902321845;5875.971704951702;5897.085951677497;5898.970505147447;5904.084866845646;5913.58604897653;5616.522595579421;5618.49433550966;5619.803306884403;5623.2127502148915;5623.943760562342;5539.861503462445;5711.228984087095;5724.914126288026;5764.164196191445;5817.970910145422;5520.089185284383;5561.749721262634;5565.16522521625;5573.888522229614;5577.693226872561;5551.694656793915;5564.081926482085;5566.805161819317;5568.610197286151;5569.554435645057;5340.279062326536;5490.3411590609385;5522.475364840334;5523.751431185526;5575.386707462257;5542.69515176653;5592.133219351007;5599.552035837205;5602;5605.1872478491205;5327.200919862052;5439.292891924025;5457.836264912059;5463.754131064032;5515.696636685021 06:05:19 INFO - PROCESS | 25618 | |1;ext.html;590.6338070396355;638.9329120442356;647.8477557773922;653.5784419049711;670.3798985938006;26510.999999999975;27141.864290678568;27160.32099197521;27215;27231;36568.634313656854;37744.245115097685;37784.43323350152;37803.4329485058;37807.24385512295;8404.327653787714;8618.56907154643;8623.784405389853;8625.95687021564;8628.827423451527;8417.200365965224;8525.232729054384;8535.658573657047;8537.317014638815;8549.273311768507;8492.78768030798;8561.95719021404;8573.614187361552;8581.356398270123;8596.355273354493;8706.303495720358;8768.649254029831;8771.03518612952;8779.429337093068;8781.517016564054;8618.698345557876;8726.38915275931;8729.170728780755;8729.388942774009;8734.694285700034;39503.604963950565;40012.39981400281;40040.79979600113;40060.19879602391;40191.196176076606;3394.405978953673;3480.1821571930577;3512.244867353506;3523.9295214095832;3606.5131207286945;30797.846010770027;31300;31495.527567086512;31495.84252078725;31745.20636984094;4250.829966801324;4253.766042867641;4257.680673949466;4329.5453977332245;4430.800613972379;288153;289353;292152;293619;293832.99999999785;53131.01517386211;53314.20028699573;53380.73309633427;53673.731631341594;53739.73130134402;52862.47137528652;56665.150022749694;58204.708976454844;58402.7079864598;58408.70795645995;14183.361748721332;14348.569542913729;14355.066920650124;14357.92315576315;14358.928205358907;9995.200383969264;10830.40432776205;10845.728856778485;10861.40262285582;10877.292975956538;15237.923810380877;15604;15667.686646267239;15719.842801572067;15825.841741582668;5836.854078648068;5855.268091488564;5892.410758924073;5974.790882319098;6002.789902353396;1049.3861091261697;1064.2922456566296;1101.8071837428417;1133.3992983718642;1151.2919554474106;30793.538096928565;31602;32984.83507582447;33004.35601074851;35730.28539429249;1126.4987080748988;1128.6614015795228;1129.1982692288402;1171.4435643069473;1187.9346635934933;15376.61558461025;15950.282237299349;16155.67688646244;16177.272022759003;16333.918330408273;447390;453742;453884;454203;454522;52673.2099018515;53031.73484132632;53164.73417632887;53176;53201.2019819703;1352.6956434802091;1414.0525847682077;1418.9858101418854;1430.6351880270465;1488.6129606302222;28766.71233287724;29666.406671866873;29876.551851721808;29941.55087673643;29993.700062999964;46646.76676616731;46795.532044679116;47138.292925605456;47150;47276.7636161817;420655;421995;423374;423690;424111;24031;26614.86692566602;26623.86688066547;27378.452430951667;27689.58465622977;38330;38539.6146038536;39250.6074939247;39674.40488392619;39901;32511.837440812644;33486.33027339488;35819.82090089533;37300;37675.43486847645;36639;36681.44977825388;36750.63249367472;36886;37252.25495490129;36948.630513694516;37653.62346376501;37832;37869.62130378661;37909.431358529095;31460.685393145777;33040;33340.83329583434;33405.33189336248;33469.33061338808;25601.48797024012;26170.607440888783;26224.34439139037;26232.606510902733;26320 06:05:19 INFO - PROCESS | 25618 | |2;jquery.html;383.41529168018775;394.27453485586534;397.11245366605647;397.57260944484676;406.30724614532227;13778.931105344484;15148;17645.11774411279;18262.178201980925;18301.542461438454;12946.417411216518;17212.31150753968;17260.482185534423;17472.301107955667;17759.11204439776;5268.209768534713;5284.471552844713;5344.679319240839;5401.540869026137;5481.5340696040885;3814.8855534334016;5359.383670877841;5380.354357477108;5410.972945135289;5775.942240577582;5991.970040149793;6011.849703757419;6034.8793024139495;6038.667873266969;6039.094135879609;5229.372475302969;5496.203050557647;5502.9174562381595;5985.850353741148;5986.491148252404;5259.158534634478;5280.313559237275;5286.127788914824;5322.068637988336;5354.705491197982;13111.213327200303;13230.933845330712;13471.797923031163;13522;15582.298796554182;2281.121768119286;2284.9543009139725;2299.5745787029455;2384.880755962195;2415.1667674652217;9538.284628652878;9888.357256778287;10140.594376224943;10489.21330900178;13589.184648921097;1733.5839398544385;1743.1894169211378;1789.2485156234413;1801.261482792049;1878.2017642501883;69265.96101058437;72224.27775722228;74061.25938740598;76752;77910.88356465734;9705.514724263758;9802.803943921082;9989.550470228856;10000.099991000845;10174.745631359276;13761.518346857813;13864.861351386558;13993.790093148611;14002.579922602134;14019.649508762363;6388.8083357499345;6898.896516552256;7391.889121663179;7403.481756277009;7577.810554736066;6665.500087493458;6670.933290667128;6677.265500794909;6806.319368063253;6974.546654467444;4395.758233297135;4436.889077773081;4450.443694538183;4471.329300604935;4478.753668548261;1854.5827188882663;1863.1708889544293;1885.5757454572886;1892.7350170976074;1935.129191863667;881.8677198420288;948.5968463403026;974;1001.6196826217044;1047.6856942917095;17094.91452542729;17254.396096136574;17520.82479175192;17884.821151788576;18428;890.9287257019423;969.6266937229077;979.7501637082498;990.9950450247702;991.5785791038779;9476.715698529055;9679.70960871161;9812.150972939955;10057.245706572035;10253.487325633689;477925;485343;487092;495226;497184;87493;91071.54464227636;91151;93295.53352233196;93328;1000.46475135802;1000.474750755859;1080.5947769586405;1109.4563663804677;1113.5935383585095;15807.604809879846;15816.288267028242;15824.44614438489;16033.198340083183;16324.755128672841;36861.631383686894;36886;36967;37001;37371.25257494889;54084;54409.45590544044;56415.71792141177;56659;57312.713436432554;7890.526568405914;8009.519428834288;8273.475801694438;8293.377996650395;8417;8692.174243446863;11329.943350283196;12157.69605759863;12212;12430.81353779676;10012.249081318785;11053;11074.889251107386;11235.269707468988;11388.715282117682;10592.735181620521;10854.565817367216;10883.619073332395;10977.231593788678;11015.669529914116;9722.659706910224;10142.949285253526;10787.029167374974;10850.186236032172;10950.397728124712;8536.725506752407;8570.700025499078;8602.440841345293;8670.91329086701;8779.253763429924;10438.164946804389;10782.24524283324;10923.453827308762;10925.508352124332;10983.890161098607 06:05:19 INFO - PROCESS | 25618 | |3;mootools.html;1314.3493970484612;1498.258362110755;1500.1299246437068;1659.1123748794398;1753.964920701586;7876.488028278158;8204.548749818758;8231.835363292737;8244.91755082449;8253.422260441772;8004.759857204293;8152.714654987077;8159.020917489895;8179.550124743151;8184.590770461483;1952.9121189546504;2014.8589598728095;2020.8282296004784;2278.2254033628524;2307.238611258281;2265.954680906381;2338.53229354129;2339.6256598944174;2347.225415612852;2349.859008459498;2229.5429436965383;2294.27730264966;2295.276987748862;2302.056156975632;2303.6314189729646;1911.4265720283997;2007.4579863436863;2015.3752336775647;2017.3947815655317;2240.809531189851;2287.1880482428833;2293.7247530296304;2309.376468353552;2310.202979971907;2315.3632750993443;8113.472624279462;8159.020917489939;8173.5504547249875;8176.713815016446;8183.918160818375;4888.486708895586;5068.265101560253;5081.771320290596;5104.234364845266;5106.361704786902;3247.594050743657;3342.715869151125;3441.380551500729;3451.7928924264625;3469.5663042119736;1186.0985650905288;1190.7380376317196;1203.169812829145;1208.4380762945273;1221.291650842518;11359.943200284028;11374.090072794157;11375.544978200862;11378.943105284421;11404.087672986141;4410.757408342572;4447.533009034069;4637.884052898705;4658.836940707059;4659.930101048487;8905.554722263862;8961.417507861968;8982.056884027214;8990.056044115274;9007.928176519437;5053.393592768891;5056.241563765465;5075.746212689351;5078.847634570969;5091.1854103343285;3853.9614603854166;4642.3500709900645;4720.480747117815;4745.217039188564;4772.642051846056;3624.909377265537;3630.528031355907;3694.07648087978;3729.8881033569037;3767.6420740029653;1137.988620113805;1174.6652204121783;1178.3460179600233;1180.740237147826;1193.0574845871838;904.5432056811268;953.93322467428;965.4979410706393;974.6637410093506;997.870276864003;5518.227448157261;5541.778328866801;5599.7480113394995;5742.511886489695;5820.039693450533;414.65790722653327;420.6025306085781;434.7608815151654;434.89997300621036;441.633444241279;3674.706023518112;3698.593154752975;3727.086863718352;3772.7359084863797;3772.86794962175;9954.601815927426;10316.381017138996;10431.5827366906;10481.004304591204;10483.528241229164;10324.690259292083;10337.793244135075;10339.327943683636;10350.120239779702;10351.689449316533;7612.961935190399;7861.960690196627;7932.801679958047;7940.0868900076075;7966.561839098905;5504.4495550444635;5541.113421852484;5636.718164091861;5673.290838645169;5719.399463056486;9302.813943721223;9326.160645541933;9495.572699228413;9612.807743845224;9679.854802178113;9415.152636262495;9646.324757266924;9739.172170365315;9773.12041916231;9797.804043919225;6301.653409062362;6727.764528241488;6899.516603930179;7017.578945263301;7068.045813815274;7974.840503189787;8028.116907140093;8048.396370272136;8093.55485448306;8104.108548059827;6948.096747422803;7088.113985751781;7119.715211391486;7209.6034718091005;7246.6376681164675;7092.822679433056;7107.538010029331;7181.533200341961;7191.460640452092;7208.026916366223;6488.578242414228;6601.768938087144;6623.072769812326;6624.105745724266;6625.4699624029;4814.446338671098;4851.175300198904;4955.925661115159;4961.107000739901;4989.9251511228085;4847.95152048475;4937.23472861707;4990;5020.121478741133;5070.036693028313 06:05:19 INFO - PROCESS | 25618 | |4;prototype.html;334.8175244491752;335.9109835893487;338.25921232500815;342.14463840399003;346.60833258417983;5634.464725851048;5759.39526349733;5762.452567006138;5768.423157684229;5769.076947688365;5647.745851436685;5661.745221465034;5676.375598684142;5685.943140568604;5686.0902255639;4149.709520333586;4224.197402493516;4394.5385734497895;4417.42573465449;4452.799624016927;4410.404595379615;4413.4041904342985;4416.933745993812;4427;4428.734275943438;4176;4352.717073390236;4360.389545463638;4373.103513779683;4379.671524635649;4243.702940794145;4258.467691538558;4360.171567402183;4387.846425375096;4417.580329868657;3860.1507668312925;3873.2447172801317;3883;3891.6184754412343;3891.747036442622;5325.387580428262;5424.783008679648;5464.863378415532;5480.342358916955;5513.766924395626;5075.390953085654;5078.21287700407;5078.390593128848;5080.212567052113;5085.898282034375;5943.3165186003735;5955.612885162451;5968.462838344526;5983.461488466015;5995.640261584275;4179.665626749883;4264.0832221072305;4270.316749320094;4273.807678654468;4275.358696195564;6179.3820617937845;6183.876322473526;6216.222972128484;6220.377962203788;6232;4368.453943257093;4372.540883207281;4378.671599630041;4389.604935555815;4402.911941761146;4311.288637374861;4421.214634780068;4428.247197976351;4434.091011342667;4436;5061.582756828094;5065.809534759329;5066.240063990431;5073.518015788494;5083.949160508421;6007.909881351783;6021.307549631849;6030.7889223876955;6046.879062418727;6054.182685337511;1495.7307684616874;1527.5035613425682;1549.333786471828;1550.333356656626;1553.6659618182146;978.7846673731767;1011.9797604048025;1012.2661070723666;1029.5264178477835;1068.4817863336275;5633.802816901471;5684.914726279109;5700.173474846124;5703.258576385043;5725.51333136688;6033.698315084228;6041.093835924647;6059.1820104286235;6095.8476038098515;6099.9085013724825;5512.200730894078;5690.9146362804595;5770.16332631766;5778.566607504454;5857.26784151981;3292.7695061345476;3324.6010478742705;3333.93332133356;3339.2653616204884;3342.1477523231906;6284.340144284784;6349.142865713162;6419.325970773095;6477.255115661665;6486.2216534016225;6315.5263355247625;6319;6340.8414789629705;6344.904826427607;6346.397092276226;6164.167837341902;6381.361863813581;6390.201224846895;6414.358564143642;6423.229212494531;6198.72105755233;6221.875562488815;6225.782097626561;6228.4705800007505;6243.843903902439;6121.908171377522;6135.263768347827;6144.938550614436;6154.076888466766;6187.7933802908;6085.939140608537;6392.680365981775;6430.5177111715875;6436.324185960594;6458.61248325102;4262.765547894772;4262.914741705211;4264.5309016007595;4271.3165893458145;4287.957120428756;5956.434138756811;6145.187169784835;6181.443670069715;6191;6213.240989201468;6028;6058.607509555537;6063.151158837854;6072;6073.665948372882;5994;6019.9465093609315;6026.909596356146;6027.30685971119;6031.969840150771;5713.857453346291;5901.262342207224;5910.822675319747;5926;5934.287885453773;6050.122732203894;6070.605410648293;6073.635581865102;6089.665068421102;6096.573239873166;5710.3154569401295;5918.940810592011;5948.702564871825;5952.458287319038;5955.940440595712 06:05:19 INFO - PROCESS | 25618 | |5;yui.html;737.3437640499956;767.5433117295214;802.8273921106965;841.1420351241734;850.6427300533775;12460.190087644296;12722.936385318084;12738.044646651504;12739.235645861254;14110.435582576685;15060.322285497152;15090.47183348583;15100.471483498053;15119.697606047872;15123.31945062472;656.9507286953474;783.3693876429472;799.3165843204049;806.2662976691212;811.5090370325956;808.2685169921231;810.1979040749645;811.8335741173075;812.252727490707;812.4028838803474;850.1456036683124;851.1105894340399;852.2925971443718;852.8635418333037;853.0999795216045;679.7926632377123;819.737683941139;840.0129847429307;840.6217202259008;842.1199846160715;614.5728718540616;614.9631022138686;615.2555407956378;615.3999850146116;615.722924683894;13935.442582296697;13944;13988.300584970711;14005.229712365815;14009.089409188473;13491;14080.436782528686;14114.153150810984;14206.786898196535;14317.427302907976;11729;11733.941330293379;11744.706382340424;11899.524019039229;12015.93992030043;3737.196502751894;3755;3759.2857357102334;3831.67430768385;3851.5185601799776;56655.71672141613;56917;58367.416325836624;58988.41011589915;59202.11196832051;10683.985021422952;10819.026287633993;10948.258366621723;11021.559137634566;11149.944250278697;19137.61724765497;19335;19355;19358.709619355723;19359.3224237151;7937.722179723682;8156.34749220061;8307.08622051574;8429.199226073513;8497.872531912026;4449.599536041772;4484.573965473275;4801.207800712913;4833.468318484964;4908.312836202863;3338.833058347073;3358.0429577570276;3408.113890388467;3408.250184959305;3412.505186747908;536.3054843977059;619.3806193806194;635.5392340553062;649.6004956951441;663.8705452436728;607.6414915200053;613.6348872420903;668.5119862500304;744.5830335012411;752.135044698601;8845.380823342433;9027.954860225656;9424.905750942402;9501.952490237505;9683.370580912218;633.9714712837933;738.7599030315062;747.3946103656056;758.071362580834;775.751759436986;4008.659263962596;4340.175366680321;4388.956110438919;4466.3523789050405;4580.725156490621;48980.51019489831;49117.07063434917;49959;50036.49963500319;50066.24900626494;43870.600170920676;47691.284630730566;48788.26817597739;48868.02263954772;49726.25410618843;42412;43279;43418.56581434208;43856.56143438588;46765.5323446768;8924.464532128093;9190.40262382943;9229.676961306322;9479.573419196015;9521.476318802532;29649.85175074111;29651.40697186001;30545.23636909006;30701;30819.075427737203;37998.62001379951;38092.80953595214;38132.6186738129;38307.42538861975;38864;11542.59600913964;11718.179727419;11861.110416718608;11869;12209.145359824726;12915.095943283879;13024.348782560644;13112.803307950579;13619.727605448034;13764.518241861486;12640.55758048464;13116.737665246832;13254.403551839998;13368.131071480322;13472.191668499921;13049.543265985645;13486.393112309774;13499.257540835348;13819;13831.585052448443;12879;12967;13481.528146515217;13514.79727804064;13525;10510.894891050992;10571.788564228826;10819.783604328028;11186.720331991766;11675.708107297385;10802.189835762507;11126.777464450828;11130.944345278222;11333.716657083638;11363.147763917905 06:05:19 INFO - PROCESS | 25618 | __end_tp_report 06:05:19 INFO - PROCESS | 25618 | __start_cc_report 06:05:19 INFO - PROCESS | 25618 | _x_x_mozilla_cycle_collect,859 06:05:19 INFO - PROCESS | 25618 | __end_cc_report 06:05:19 INFO - PROCESS | 25618 | __startTimestamp1461503119896__endTimestamp 06:05:19 INFO - PROCESS | 25618 | 06:05:19 INFO - PROCESS | 25618 | ------- Summary: start ------- 06:05:19 INFO - PROCESS | 25618 | Number of tests: 6 06:05:19 INFO - PROCESS | 25618 | 06:05:19 INFO - PROCESS | 25618 | [#0] dojo.html Cycles:165 Average:5301.66 Median:5515.70 stddev:595.66 (10.8%) stddev-sans-first:572.25 06:05:19 INFO - PROCESS | 25618 | Values: 3114.4 3160.4 3191.2 3203.2 3228.5 5121.6 5211.3 5329.0 5339.2 5406.8 5369.3 5373.2 5387.9 5426.5 5452.1 4757.2 4773.8 4776.5 4784.2 4962.5 4883.9 4897.9 4928.7 4942.7 4958.2 4750.2 4849.9 4863.1 4898.4 4908.1 4854.6 4880.6 4886.8 4903.6 4915.5 4715.8 4801.1 4846.7 4864.5 4896.6 5309.0 5314.5 5322.3 5337.7 5367.3 5686.7 5693.1 5717.7 5721.9 5722.9 5617.8 5756.6 5761.3 5768.7 5824.0 5403.0 5406.0 5410.8 5411.9 5413.6 5851.8 5879.6 5880.2 5884.9 5890.4 5480.5 5606.9 5650.5 5692.3 5708.4 5680.3 5696.9 5699.6 5702.1 5707.5 5625.2 5626.6 5632.1 5632.3 5635.9 5523.2 5696.9 5735.0 5744.3 5786.7 4297.3 4301.2 4301.8 4308.7 4337.5 3790.5 3862.8 3864.0 3881.5 3919.5 5330.3 5362.8 5368.8 5407.1 5410.0 5697.3 5702.7 5722.8 5727.7 5740.7 5282.6 5285.8 5378.4 5387.3 5430.5 4904.1 4921.1 4926.8 4932.9 4973.1 5902.5 5906.7 5909.4 5916.0 5921.0 5598.4 5710.6 5748.3 5799.1 5804.9 5876.0 5897.1 5899.0 5904.1 5913.6 5616.5 5618.5 5619.8 5623.2 5623.9 5539.9 5711.2 5724.9 5764.2 5818.0 5520.1 5561.7 5565.2 5573.9 5577.7 5551.7 5564.1 5566.8 5568.6 5569.6 5340.3 5490.3 5522.5 5523.8 5575.4 5542.7 5592.1 5599.6 5602.0 5605.2 5327.2 5439.3 5457.8 5463.8 5515.7 06:05:19 INFO - PROCESS | 25618 | 06:05:19 INFO - PROCESS | 25618 | [#1] ext.html Cycles:180 Average:53555.73 Median:37664.53 stddev:104706.87 (278.0%) stddev-sans-first:104925.08 06:05:19 INFO - PROCESS | 25618 | Values: 590.6 638.9 647.8 653.6 670.4 26511.0 27141.9 27160.3 27215.0 27231.0 36568.6 37744.2 37784.4 37803.4 37807.2 8404.3 8618.6 8623.8 8626.0 8628.8 8417.2 8525.2 8535.7 8537.3 8549.3 8492.8 8562.0 8573.6 8581.4 8596.4 8706.3 8768.6 8771.0 8779.4 8781.5 8618.7 8726.4 8729.2 8729.4 8734.7 39503.6 40012.4 40040.8 40060.2 40191.2 3394.4 3480.2 3512.2 3523.9 3606.5 30797.8 31300.0 31495.5 31495.8 31745.2 4250.8 4253.8 4257.7 4329.5 4430.8 288153.0 289353.0 292152.0 293619.0 293833.0 53131.0 53314.2 53380.7 53673.7 53739.7 52862.5 56665.2 58204.7 58402.7 58408.7 14183.4 14348.6 14355.1 14357.9 14358.9 9995.2 10830.4 10845.7 10861.4 10877.3 15237.9 15604.0 15667.7 15719.8 15825.8 5836.9 5855.3 5892.4 5974.8 6002.8 1049.4 1064.3 1101.8 1133.4 1151.3 30793.5 31602.0 32984.8 33004.4 35730.3 1126.5 1128.7 1129.2 1171.4 1187.9 15376.6 15950.3 16155.7 16177.3 16333.9 447390.0 453742.0 453884.0 454203.0 454522.0 52673.2 53031.7 53164.7 53176.0 53201.2 1352.7 1414.1 1419.0 1430.6 1488.6 28766.7 29666.4 29876.6 29941.6 29993.7 46646.8 46795.5 47138.3 47150.0 47276.8 420655.0 421995.0 423374.0 423690.0 424111.0 24031.0 26614.9 26623.9 27378.5 27689.6 38330.0 38539.6 39250.6 39674.4 39901.0 32511.8 33486.3 35819.8 37300.0 37675.4 36639.0 36681.4 36750.6 36886.0 37252.3 36948.6 37653.6 37832.0 37869.6 37909.4 31460.7 33040.0 33340.8 33405.3 33469.3 25601.5 26170.6 26224.3 26232.6 26320.0 06:05:19 INFO - PROCESS | 25618 | 06:05:19 INFO - PROCESS | 25618 | [#2] jquery.html Cycles:180 Average:27726.22 Median:397.34 stddev:80537.77 (20269.1%) stddev-sans-first:80737.53 06:05:19 INFO - PROCESS | 25618 | Values: 383.4 394.3 397.1 397.6 406.3 13778.9 15148.0 17645.1 18262.2 18301.5 12946.4 17212.3 17260.5 17472.3 17759.1 5268.2 5284.5 5344.7 5401.5 5481.5 3814.9 5359.4 5380.4 5411.0 5775.9 5992.0 6011.8 6034.9 6038.7 6039.1 5229.4 5496.2 5502.9 5985.9 5986.5 5259.2 5280.3 5286.1 5322.1 5354.7 13111.2 13230.9 13471.8 13522.0 15582.3 2281.1 2285.0 2299.6 2384.9 2415.2 9538.3 9888.4 10140.6 10489.2 13589.2 1733.6 1743.2 1789.2 1801.3 1878.2 69266.0 72224.3 74061.3 76752.0 77910.9 9705.5 9802.8 9989.6 10000.1 10174.7 13761.5 13864.9 13993.8 14002.6 14019.6 6388.8 6898.9 7391.9 7403.5 7577.8 6665.5 6670.9 6677.3 6806.3 6974.5 4395.8 4436.9 4450.4 4471.3 4478.8 1854.6 1863.2 1885.6 1892.7 1935.1 881.9 948.6 974.0 1001.6 1047.7 17094.9 17254.4 17520.8 17884.8 18428.0 890.9 969.6 979.8 991.0 991.6 9476.7 9679.7 9812.2 10057.2 10253.5 477925.0 485343.0 487092.0 495226.0 497184.0 87493.0 91071.5 91151.0 93295.5 93328.0 1000.5 1000.5 1080.6 1109.5 1113.6 15807.6 15816.3 15824.4 16033.2 16324.8 36861.6 36886.0 36967.0 37001.0 37371.3 54084.0 54409.5 56415.7 56659.0 57312.7 7890.5 8009.5 8273.5 8293.4 8417.0 8692.2 11329.9 12157.7 12212.0 12430.8 10012.2 11053.0 11074.9 11235.3 11388.7 10592.7 10854.6 10883.6 10977.2 11015.7 9722.7 10142.9 10787.0 10850.2 10950.4 8536.7 8570.7 8602.4 8670.9 8779.3 10438.2 10782.2 10923.5 10925.5 10983.9 06:05:19 INFO - PROCESS | 25618 | 06:05:19 INFO - PROCESS | 25618 | [#3] mootools.html Cycles:180 Average:5438.66 Median:4975.52 stddev:3060.82 (61.5%) stddev-sans-first:3053.71 06:05:19 INFO - PROCESS | 25618 | Values: 1314.3 1498.3 1500.1 1659.1 1754.0 7876.5 8204.5 8231.8 8244.9 8253.4 8004.8 8152.7 8159.0 8179.6 8184.6 1952.9 2014.9 2020.8 2278.2 2307.2 2266.0 2338.5 2339.6 2347.2 2349.9 2229.5 2294.3 2295.3 2302.1 2303.6 1911.4 2007.5 2015.4 2017.4 2240.8 2287.2 2293.7 2309.4 2310.2 2315.4 8113.5 8159.0 8173.6 8176.7 8183.9 4888.5 5068.3 5081.8 5104.2 5106.4 3247.6 3342.7 3441.4 3451.8 3469.6 1186.1 1190.7 1203.2 1208.4 1221.3 11359.9 11374.1 11375.5 11378.9 11404.1 4410.8 4447.5 4637.9 4658.8 4659.9 8905.6 8961.4 8982.1 8990.1 9007.9 5053.4 5056.2 5075.7 5078.8 5091.2 3854.0 4642.4 4720.5 4745.2 4772.6 3624.9 3630.5 3694.1 3729.9 3767.6 1138.0 1174.7 1178.3 1180.7 1193.1 904.5 953.9 965.5 974.7 997.9 5518.2 5541.8 5599.7 5742.5 5820.0 414.7 420.6 434.8 434.9 441.6 3674.7 3698.6 3727.1 3772.7 3772.9 9954.6 10316.4 10431.6 10481.0 10483.5 10324.7 10337.8 10339.3 10350.1 10351.7 7613.0 7862.0 7932.8 7940.1 7966.6 5504.4 5541.1 5636.7 5673.3 5719.4 9302.8 9326.2 9495.6 9612.8 9679.9 9415.2 9646.3 9739.2 9773.1 9797.8 6301.7 6727.8 6899.5 7017.6 7068.0 7974.8 8028.1 8048.4 8093.6 8104.1 6948.1 7088.1 7119.7 7209.6 7246.6 7092.8 7107.5 7181.5 7191.5 7208.0 6488.6 6601.8 6623.1 6624.1 6625.5 4814.4 4851.2 4955.9 4961.1 4989.9 4848.0 4937.2 4990.0 5020.1 5070.0 06:05:19 INFO - PROCESS | 25618 | 06:05:19 INFO - PROCESS | 25618 | [#4] prototype.html Cycles:180 Average:5038.91 Median:5706.79 stddev:1498.83 (26.3%) stddev-sans-first:1460.85 06:05:19 INFO - PROCESS | 25618 | Values: 334.8 335.9 338.3 342.1 346.6 5634.5 5759.4 5762.5 5768.4 5769.1 5647.7 5661.7 5676.4 5685.9 5686.1 4149.7 4224.2 4394.5 4417.4 4452.8 4410.4 4413.4 4416.9 4427.0 4428.7 4176.0 4352.7 4360.4 4373.1 4379.7 4243.7 4258.5 4360.2 4387.8 4417.6 3860.2 3873.2 3883.0 3891.6 3891.7 5325.4 5424.8 5464.9 5480.3 5513.8 5075.4 5078.2 5078.4 5080.2 5085.9 5943.3 5955.6 5968.5 5983.5 5995.6 4179.7 4264.1 4270.3 4273.8 4275.4 6179.4 6183.9 6216.2 6220.4 6232.0 4368.5 4372.5 4378.7 4389.6 4402.9 4311.3 4421.2 4428.2 4434.1 4436.0 5061.6 5065.8 5066.2 5073.5 5083.9 6007.9 6021.3 6030.8 6046.9 6054.2 1495.7 1527.5 1549.3 1550.3 1553.7 978.8 1012.0 1012.3 1029.5 1068.5 5633.8 5684.9 5700.2 5703.3 5725.5 6033.7 6041.1 6059.2 6095.8 6099.9 5512.2 5690.9 5770.2 5778.6 5857.3 3292.8 3324.6 3333.9 3339.3 3342.1 6284.3 6349.1 6419.3 6477.3 6486.2 6315.5 6319.0 6340.8 6344.9 6346.4 6164.2 6381.4 6390.2 6414.4 6423.2 6198.7 6221.9 6225.8 6228.5 6243.8 6121.9 6135.3 6144.9 6154.1 6187.8 6085.9 6392.7 6430.5 6436.3 6458.6 4262.8 4262.9 4264.5 4271.3 4288.0 5956.4 6145.2 6181.4 6191.0 6213.2 6028.0 6058.6 6063.2 6072.0 6073.7 5994.0 6019.9 6026.9 6027.3 6032.0 5713.9 5901.3 5910.8 5926.0 5934.3 6050.1 6070.6 6073.6 6089.7 6096.6 5710.3 5918.9 5948.7 5952.5 5955.9 06:05:19 INFO - PROCESS | 25618 | 06:05:19 INFO - PROCESS | 25618 | [#5] yui.html Cycles:180 Average:13972.97 Median:23210.33 stddev:15166.43 (65.3%) stddev-sans-first:15176.40 06:05:19 INFO - PROCESS | 25618 | Values: 737.3 767.5 802.8 841.1 850.6 12460.2 12722.9 12738.0 12739.2 14110.4 15060.3 15090.5 15100.5 15119.7 15123.3 657.0 783.4 799.3 806.3 811.5 808.3 810.2 811.8 812.3 812.4 850.1 851.1 852.3 852.9 853.1 679.8 819.7 840.0 840.6 842.1 614.6 615.0 615.3 615.4 615.7 13935.4 13944.0 13988.3 14005.2 14009.1 13491.0 14080.4 14114.2 14206.8 14317.4 11729.0 11733.9 11744.7 11899.5 12015.9 3737.2 3755.0 3759.3 3831.7 3851.5 56655.7 56917.0 58367.4 58988.4 59202.1 10684.0 10819.0 10948.3 11021.6 11149.9 19137.6 19335.0 19355.0 19358.7 19359.3 7937.7 8156.3 8307.1 8429.2 8497.9 4449.6 4484.6 4801.2 4833.5 4908.3 3338.8 3358.0 3408.1 3408.3 3412.5 536.3 619.4 635.5 649.6 663.9 607.6 613.6 668.5 744.6 752.1 8845.4 9028.0 9424.9 9502.0 9683.4 634.0 738.8 747.4 758.1 775.8 4008.7 4340.2 4389.0 4466.4 4580.7 48980.5 49117.1 49959.0 50036.5 50066.2 43870.6 47691.3 48788.3 48868.0 49726.3 42412.0 43279.0 43418.6 43856.6 46765.5 8924.5 9190.4 9229.7 9479.6 9521.5 29649.9 29651.4 30545.2 30701.0 30819.1 37998.6 38092.8 38132.6 38307.4 38864.0 11542.6 11718.2 11861.1 11869.0 12209.1 12915.1 13024.3 13112.8 13619.7 13764.5 12640.6 13116.7 13254.4 13368.1 13472.2 13049.5 13486.4 13499.3 13819.0 13831.6 12879.0 12967.0 13481.5 13514.8 13525.0 10510.9 10571.8 10819.8 11186.7 11675.7 10802.2 11126.8 11130.9 11333.7 11363.1 06:05:19 INFO - PROCESS | 25618 | -------- Summary: end -------- 06:05:19 INFO - PROCESS | 25618 | 06:05:20 INFO - TEST-INFO | 25618: exit 0 06:05:20 INFO - TEST-OK | dromaeo_css | took 1112016ms 06:05:20 INFO - TEST-START | kraken 06:05:20 INFO - operating with platform_type : linux_ 06:05:20 INFO - Initialising browser for kraken test... 06:05:20 INFO - TEST-INFO | started process 25799 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprSQ34t/profile http://localhost:46171/getInfo.html) 06:05:24 INFO - PROCESS | 25799 | __metrics Screen width/height:1600/1200 06:05:24 INFO - PROCESS | 25799 | colorDepth:24 06:05:24 INFO - PROCESS | 25799 | Browser inner width/height: 1024/697 06:05:24 INFO - PROCESS | 25799 | __metrics 06:05:25 ERROR - PROCESS | 25799 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:05:26 INFO - TEST-INFO | 25799: exit 0 06:05:26 INFO - Browser initialized. 06:05:26 INFO - Running cycle 1/1 for kraken test... 06:05:26 INFO - TEST-INFO | started process 25882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprSQ34t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:38 INFO - PROCESS | 25882 | RSS: Main: 153751552 06:05:38 INFO - PROCESS | 25882 | 06:05:40 INFO - PROCESS | 25882 | Cycle 1(1): loaded http://localhost:46171/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46171/tests/kraken/driver.html?testName=audio-beat-detection) 06:05:41 INFO - PROCESS | 25882 | RSS: Main: 209358848 06:05:41 INFO - PROCESS | 25882 | 06:05:44 INFO - PROCESS | 25882 | Cycle 1(1): loaded http://localhost:46171/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46171/tests/kraken/driver.html?testName=audio-dft) 06:05:45 INFO - PROCESS | 25882 | RSS: Main: 195923968 06:05:45 INFO - PROCESS | 25882 | 06:05:48 INFO - PROCESS | 25882 | Cycle 1(1): loaded http://localhost:46171/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46171/tests/kraken/driver.html?testName=audio-fft) 06:05:48 INFO - PROCESS | 25882 | RSS: Main: 265326592 06:05:48 INFO - PROCESS | 25882 | 06:05:50 INFO - PROCESS | 25882 | Cycle 1(1): loaded http://localhost:46171/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46171/tests/kraken/driver.html?testName=audio-oscillator) 06:05:51 INFO - PROCESS | 25882 | RSS: Main: 173768704 06:05:51 INFO - PROCESS | 25882 | 06:05:53 INFO - PROCESS | 25882 | Cycle 1(1): loaded http://localhost:46171/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46171/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:54 INFO - PROCESS | 25882 | RSS: Main: 178171904 06:05:54 INFO - PROCESS | 25882 | 06:05:57 INFO - PROCESS | 25882 | Cycle 1(1): loaded http://localhost:46171/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46171/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:57 INFO - PROCESS | 25882 | RSS: Main: 213897216 06:05:57 INFO - PROCESS | 25882 | 06:06:01 INFO - PROCESS | 25882 | Cycle 1(1): loaded http://localhost:46171/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46171/tests/kraken/driver.html?testName=imaging-desaturate) 06:06:01 INFO - PROCESS | 25882 | RSS: Main: 214777856 06:06:01 INFO - PROCESS | 25882 | 06:06:04 INFO - PROCESS | 25882 | Cycle 1(1): loaded http://localhost:46171/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46171/tests/kraken/driver.html?testName=json-parse-financial) 06:06:05 INFO - PROCESS | 25882 | RSS: Main: 214478848 06:06:05 INFO - PROCESS | 25882 | 06:06:06 INFO - PROCESS | 25882 | Cycle 1(1): loaded http://localhost:46171/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46171/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:06:07 INFO - PROCESS | 25882 | RSS: Main: 201035776 06:06:07 INFO - PROCESS | 25882 | 06:06:09 INFO - PROCESS | 25882 | Cycle 1(1): loaded http://localhost:46171/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46171/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:06:09 INFO - PROCESS | 25882 | RSS: Main: 204877824 06:06:09 INFO - PROCESS | 25882 | 06:06:11 INFO - PROCESS | 25882 | Cycle 1(1): loaded http://localhost:46171/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46171/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:06:12 INFO - PROCESS | 25882 | RSS: Main: 214315008 06:06:12 INFO - PROCESS | 25882 | 06:06:14 INFO - PROCESS | 25882 | Cycle 1(1): loaded http://localhost:46171/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:06:15 INFO - PROCESS | 25882 | RSS: Main: 224239616 06:06:15 INFO - PROCESS | 25882 | 06:06:18 INFO - PROCESS | 25882 | Cycle 1(1): loaded http://localhost:46171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:06:18 INFO - PROCESS | 25882 | RSS: Main: 219799552 06:06:18 INFO - PROCESS | 25882 | 06:06:20 INFO - PROCESS | 25882 | Cycle 1(1): loaded http://localhost:46171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46171/tests/kraken/driver.html?testName=ai-astar) 06:06:20 INFO - PROCESS | 25882 | RSS: Main: 283115520 06:06:20 INFO - PROCESS | 25882 | 06:06:20 INFO - PROCESS | 25882 | __start_tp_report 06:06:20 INFO - PROCESS | 25882 | _x_x_mozilla_page_load 06:06:20 INFO - PROCESS | 25882 | _x_x_mozilla_page_load_details 06:06:20 INFO - PROCESS | 25882 | |i|pagename|runs| 06:06:20 INFO - PROCESS | 25882 | |0;ai-astar;110;111;105;110;110;112;101;111;110;111 06:06:20 INFO - PROCESS | 25882 | |1;audio-beat-detection;161;127;170;187;128;158;151;128;177;135 06:06:20 INFO - PROCESS | 25882 | |2;audio-dft;160;163;160;161;159;161;161;160;160;161 06:06:20 INFO - PROCESS | 25882 | |3;audio-fft;72;76;127;117;76;75;75;125;109;76 06:06:20 INFO - PROCESS | 25882 | |4;audio-oscillator;92;93;148;93;94;93;144;93;92;145 06:06:20 INFO - PROCESS | 25882 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 06:06:20 INFO - PROCESS | 25882 | |6;imaging-darkroom;145;147;145;146;145;145;145;145;145;146 06:06:20 INFO - PROCESS | 25882 | |7;imaging-desaturate;95;94;94;95;94;94;94;94;94;94 06:06:20 INFO - PROCESS | 25882 | |8;json-parse-financial;59;60;58;57;58;58;58;77;57;56 06:06:20 INFO - PROCESS | 25882 | |9;json-stringify-tinderbox;62;62;62;61;61;61;60;62;62;62 06:06:20 INFO - PROCESS | 25882 | |10;stanford-crypto-aes;77;78;77;77;79;78;78;79;88;78 06:06:20 INFO - PROCESS | 25882 | |11;stanford-crypto-ccm;127;127;125;125;124;123;127;126;164;131 06:06:20 INFO - PROCESS | 25882 | |12;stanford-crypto-pbkdf2;166;168;170;177;174;170;165;167;167;170 06:06:20 INFO - PROCESS | 25882 | |13;stanford-crypto-sha256-iterative;70;68;69;68;67;66;68;70;67;68 06:06:20 INFO - PROCESS | 25882 | __end_tp_report 06:06:20 INFO - PROCESS | 25882 | __start_cc_report 06:06:20 INFO - PROCESS | 25882 | _x_x_mozilla_cycle_collect,1640 06:06:20 INFO - PROCESS | 25882 | __end_cc_report 06:06:20 INFO - PROCESS | 25882 | __startTimestamp1461503180830__endTimestamp 06:06:20 INFO - PROCESS | 25882 | 06:06:20 INFO - PROCESS | 25882 | ------- Summary: start ------- 06:06:20 INFO - PROCESS | 25882 | Number of tests: 14 06:06:20 INFO - PROCESS | 25882 | 06:06:20 INFO - PROCESS | 25882 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:3.41 (3.1%) stddev-sans-first:3.61 06:06:20 INFO - PROCESS | 25882 | Values: 110.0 111.0 105.0 110.0 110.0 112.0 101.0 111.0 110.0 111.0 06:06:20 INFO - PROCESS | 25882 | 06:06:20 INFO - PROCESS | 25882 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:159.50 stddev:22.00 (13.8%) stddev-sans-first:23.11 06:06:20 INFO - PROCESS | 25882 | Values: 161.0 127.0 170.0 187.0 128.0 158.0 151.0 128.0 177.0 135.0 06:06:20 INFO - PROCESS | 25882 | 06:06:20 INFO - PROCESS | 25882 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 06:06:20 INFO - PROCESS | 25882 | Values: 160.0 163.0 160.0 161.0 159.0 161.0 161.0 160.0 160.0 161.0 06:06:20 INFO - PROCESS | 25882 | 06:06:20 INFO - PROCESS | 25882 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.00 stddev:23.49 (31.3%) stddev-sans-first:23.68 06:06:20 INFO - PROCESS | 25882 | Values: 72.0 76.0 127.0 117.0 76.0 75.0 75.0 125.0 109.0 76.0 06:06:20 INFO - PROCESS | 25882 | 06:06:20 INFO - PROCESS | 25882 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:93.00 stddev:25.53 (27.5%) stddev-sans-first:26.36 06:06:20 INFO - PROCESS | 25882 | Values: 92.0 93.0 148.0 93.0 94.0 93.0 144.0 93.0 92.0 145.0 06:06:20 INFO - PROCESS | 25882 | 06:06:20 INFO - PROCESS | 25882 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 06:06:20 INFO - PROCESS | 25882 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 06:06:20 INFO - PROCESS | 25882 | 06:06:20 INFO - PROCESS | 25882 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 06:06:20 INFO - PROCESS | 25882 | Values: 145.0 147.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 06:06:20 INFO - PROCESS | 25882 | 06:06:20 INFO - PROCESS | 25882 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:06:20 INFO - PROCESS | 25882 | Values: 95.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 06:06:20 INFO - PROCESS | 25882 | 06:06:20 INFO - PROCESS | 25882 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:58.00 stddev:6.14 (10.6%) stddev-sans-first:6.51 06:06:20 INFO - PROCESS | 25882 | Values: 59.0 60.0 58.0 57.0 58.0 58.0 58.0 77.0 57.0 56.0 06:06:20 INFO - PROCESS | 25882 | 06:06:20 INFO - PROCESS | 25882 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 06:06:20 INFO - PROCESS | 25882 | Values: 62.0 62.0 62.0 61.0 61.0 61.0 60.0 62.0 62.0 62.0 06:06:20 INFO - PROCESS | 25882 | 06:06:20 INFO - PROCESS | 25882 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:78.00 stddev:3.28 (4.2%) stddev-sans-first:3.41 06:06:20 INFO - PROCESS | 25882 | Values: 77.0 78.0 77.0 77.0 79.0 78.0 78.0 79.0 88.0 78.0 06:06:20 INFO - PROCESS | 25882 | 06:06:20 INFO - PROCESS | 25882 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:127.00 stddev:12.18 (9.6%) stddev-sans-first:12.87 06:06:20 INFO - PROCESS | 25882 | Values: 127.0 127.0 125.0 125.0 124.0 123.0 127.0 126.0 164.0 131.0 06:06:20 INFO - PROCESS | 25882 | 06:06:20 INFO - PROCESS | 25882 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:170.00 stddev:3.72 (2.2%) stddev-sans-first:3.73 06:06:20 INFO - PROCESS | 25882 | Values: 166.0 168.0 170.0 177.0 174.0 170.0 165.0 167.0 167.0 170.0 06:06:20 INFO - PROCESS | 25882 | 06:06:20 INFO - PROCESS | 25882 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.29 (1.9%) stddev-sans-first:1.17 06:06:20 INFO - PROCESS | 25882 | Values: 70.0 68.0 69.0 68.0 67.0 66.0 68.0 70.0 67.0 68.0 06:06:20 INFO - PROCESS | 25882 | -------- Summary: end -------- 06:06:20 INFO - PROCESS | 25882 | 06:06:21 INFO - TEST-INFO | 25882: exit 0 06:06:21 INFO - TEST-OK | kraken | took 61142ms 06:06:21 INFO - SUITE-END | took 1173s 06:06:21 INFO - Completed test suite (00:19:33) 06:06:21 INFO - javascript benchmark 06:06:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.4394009078364, 3160.367926414715, 3191.1543440988125, 3203.1831882869865, 3228.5480032795413, 5121.6414850960355, 5211.348581427322, 5329.0, 5339.199120131977, 5406.783728650849, 5369.275147855048, 5373.194020896867, 5387.946120538793, 5426.538744206738, 5452.100403433429, 4757.167495688258, 4773.76131193439, 4776.546228108324, 4784.162771514971, 4962.478939711333, 4883.902321953558, 4897.902041959159, 4928.704277743347, 4942.728149951751, 4958.157113290731, 4750.216214324632, 4849.854504364875, 4863.124637565237, 4898.387701537308, 4908.141075311806, 4854.587360074398, 4880.6095512358925, 4886.780094895703, 4903.607711383081, 4915.5330243626795, 4715.811367545294, 4801.087793319258, 4846.684965477232, 4864.537868902484, 4896.583790377822, 5309.044372013036, 5314.468553144693, 5322.33470816148, 5337.653052551572, 5367.329083864517, 5686.744096515667, 5693.089105743061, 5717.742701578439, 5721.914171287434, 5722.885542289173, 5617.775288988436, 5756.597038207327, 5761.337446193699, 5768.740406681667, 5824.0, 5402.9729851350885, 5406.02691515531, 5410.810621628224, 5411.864703382447, 5413.593980451482, 5851.824445266649, 5879.617824841372, 5880.206172166702, 5884.852878678067, 5890.410958904161, 5480.534154596904, 5606.859828504238, 5650.491455768918, 5692.31692196939, 5708.429157084258, 5680.289963754531, 5696.857578560569, 5699.629524081004, 5702.144678298206, 5707.514861236841, 5625.212470254168, 5626.578006649435, 5632.098864181793, 5632.295963004624, 5635.943640563624, 5523.1991361253195, 5696.8860622787315, 5734.99637563433, 5744.281964754406, 5786.681732504752, 4297.269464191095, 4301.182775272689, 4301.78491075445, 4308.67684923632, 4337.457817772778, 3790.5261842269715, 3862.7682339059747, 3863.9613603864163, 3881.4565960765517, 3919.451276821247, 5330.333708286465, 5362.839114826484, 5368.812091576776, 5407.107827208545, 5410.0, 5697.259356283656, 5702.6863522506665, 5722.828315150552, 5727.6849773262875, 5740.741666625012, 5282.550983166397, 5285.762140703678, 5378.354597448253, 5387.326584176978, 5430.538404235605, 4904.141775189399, 4921.114199444134, 4926.827561035347, 4932.926006109911, 4973.055119527278, 5902.498287645598, 5906.704664766745, 5909.379515150933, 5916.0, 5920.970395147997, 5598.412166722435, 5710.628809127394, 5748.252727145445, 5799.130130480462, 5804.883902321845, 5875.971704951702, 5897.085951677497, 5898.970505147447, 5904.084866845646, 5913.58604897653, 5616.522595579421, 5618.49433550966, 5619.803306884403, 5623.2127502148915, 5623.943760562342, 5539.861503462445, 5711.228984087095, 5724.914126288026, 5764.164196191445, 5817.970910145422, 5520.089185284383, 5561.749721262634, 5565.16522521625, 5573.888522229614, 5577.693226872561, 5551.694656793915, 5564.081926482085, 5566.805161819317, 5568.610197286151, 5569.554435645057, 5340.279062326536, 5490.3411590609385, 5522.475364840334, 5523.751431185526, 5575.386707462257, 5542.69515176653, 5592.133219351007, 5599.552035837205, 5602.0, 5605.1872478491205, 5327.200919862052, 5439.292891924025, 5457.836264912059, 5463.754131064032, 5515.696636685021], "value": 5262.3153094176705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.6338070396355, 638.9329120442356, 647.8477557773922, 653.5784419049711, 670.3798985938006, 26510.999999999975, 27141.864290678568, 27160.32099197521, 27215.0, 27231.0, 36568.634313656854, 37744.245115097685, 37784.43323350152, 37803.4329485058, 37807.24385512295, 8404.327653787714, 8618.56907154643, 8623.784405389853, 8625.95687021564, 8628.827423451527, 8417.200365965224, 8525.232729054384, 8535.658573657047, 8537.317014638815, 8549.273311768507, 8492.78768030798, 8561.95719021404, 8573.614187361552, 8581.356398270123, 8596.355273354493, 8706.303495720358, 8768.649254029831, 8771.03518612952, 8779.429337093068, 8781.517016564054, 8618.698345557876, 8726.38915275931, 8729.170728780755, 8729.388942774009, 8734.694285700034, 39503.604963950565, 40012.39981400281, 40040.79979600113, 40060.19879602391, 40191.196176076606, 3394.405978953673, 3480.1821571930577, 3512.244867353506, 3523.9295214095832, 3606.5131207286945, 30797.846010770027, 31300.0, 31495.527567086512, 31495.84252078725, 31745.20636984094, 4250.829966801324, 4253.766042867641, 4257.680673949466, 4329.5453977332245, 4430.800613972379, 288153.0, 289353.0, 292152.0, 293619.0, 293832.99999999785, 53131.01517386211, 53314.20028699573, 53380.73309633427, 53673.731631341594, 53739.73130134402, 52862.47137528652, 56665.150022749694, 58204.708976454844, 58402.7079864598, 58408.70795645995, 14183.361748721332, 14348.569542913729, 14355.066920650124, 14357.92315576315, 14358.928205358907, 9995.200383969264, 10830.40432776205, 10845.728856778485, 10861.40262285582, 10877.292975956538, 15237.923810380877, 15604.0, 15667.686646267239, 15719.842801572067, 15825.841741582668, 5836.854078648068, 5855.268091488564, 5892.410758924073, 5974.790882319098, 6002.789902353396, 1049.3861091261697, 1064.2922456566296, 1101.8071837428417, 1133.3992983718642, 1151.2919554474106, 30793.538096928565, 31602.0, 32984.83507582447, 33004.35601074851, 35730.28539429249, 1126.4987080748988, 1128.6614015795228, 1129.1982692288402, 1171.4435643069473, 1187.9346635934933, 15376.61558461025, 15950.282237299349, 16155.67688646244, 16177.272022759003, 16333.918330408273, 447390.0, 453742.0, 453884.0, 454203.0, 454522.0, 52673.2099018515, 53031.73484132632, 53164.73417632887, 53176.0, 53201.2019819703, 1352.6956434802091, 1414.0525847682077, 1418.9858101418854, 1430.6351880270465, 1488.6129606302222, 28766.71233287724, 29666.406671866873, 29876.551851721808, 29941.55087673643, 29993.700062999964, 46646.76676616731, 46795.532044679116, 47138.292925605456, 47150.0, 47276.7636161817, 420655.0, 421995.0, 423374.0, 423690.0, 424111.0, 24031.0, 26614.86692566602, 26623.86688066547, 27378.452430951667, 27689.58465622977, 38330.0, 38539.6146038536, 39250.6074939247, 39674.40488392619, 39901.0, 32511.837440812644, 33486.33027339488, 35819.82090089533, 37300.0, 37675.43486847645, 36639.0, 36681.44977825388, 36750.63249367472, 36886.0, 37252.25495490129, 36948.630513694516, 37653.62346376501, 37832.0, 37869.62130378661, 37909.431358529095, 31460.685393145777, 33040.0, 33340.83329583434, 33405.33189336248, 33469.33061338808, 25601.48797024012, 26170.607440888783, 26224.34439139037, 26232.606510902733, 26320.0], "value": 18517.67073602797, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.41529168018775, 394.27453485586534, 397.11245366605647, 397.57260944484676, 406.30724614532227, 13778.931105344484, 15148.0, 17645.11774411279, 18262.178201980925, 18301.542461438454, 12946.417411216518, 17212.31150753968, 17260.482185534423, 17472.301107955667, 17759.11204439776, 5268.209768534713, 5284.471552844713, 5344.679319240839, 5401.540869026137, 5481.5340696040885, 3814.8855534334016, 5359.383670877841, 5380.354357477108, 5410.972945135289, 5775.942240577582, 5991.970040149793, 6011.849703757419, 6034.8793024139495, 6038.667873266969, 6039.094135879609, 5229.372475302969, 5496.203050557647, 5502.9174562381595, 5985.850353741148, 5986.491148252404, 5259.158534634478, 5280.313559237275, 5286.127788914824, 5322.068637988336, 5354.705491197982, 13111.213327200303, 13230.933845330712, 13471.797923031163, 13522.0, 15582.298796554182, 2281.121768119286, 2284.9543009139725, 2299.5745787029455, 2384.880755962195, 2415.1667674652217, 9538.284628652878, 9888.357256778287, 10140.594376224943, 10489.21330900178, 13589.184648921097, 1733.5839398544385, 1743.1894169211378, 1789.2485156234413, 1801.261482792049, 1878.2017642501883, 69265.96101058437, 72224.27775722228, 74061.25938740598, 76752.0, 77910.88356465734, 9705.514724263758, 9802.803943921082, 9989.550470228856, 10000.099991000845, 10174.745631359276, 13761.518346857813, 13864.861351386558, 13993.790093148611, 14002.579922602134, 14019.649508762363, 6388.8083357499345, 6898.896516552256, 7391.889121663179, 7403.481756277009, 7577.810554736066, 6665.500087493458, 6670.933290667128, 6677.265500794909, 6806.319368063253, 6974.546654467444, 4395.758233297135, 4436.889077773081, 4450.443694538183, 4471.329300604935, 4478.753668548261, 1854.5827188882663, 1863.1708889544293, 1885.5757454572886, 1892.7350170976074, 1935.129191863667, 881.8677198420288, 948.5968463403026, 974.0, 1001.6196826217044, 1047.6856942917095, 17094.91452542729, 17254.396096136574, 17520.82479175192, 17884.821151788576, 18428.0, 890.9287257019423, 969.6266937229077, 979.7501637082498, 990.9950450247702, 991.5785791038779, 9476.715698529055, 9679.70960871161, 9812.150972939955, 10057.245706572035, 10253.487325633689, 477925.0, 485343.0, 487092.0, 495226.0, 497184.0, 87493.0, 91071.54464227636, 91151.0, 93295.53352233196, 93328.0, 1000.46475135802, 1000.474750755859, 1080.5947769586405, 1109.4563663804677, 1113.5935383585095, 15807.604809879846, 15816.288267028242, 15824.44614438489, 16033.198340083183, 16324.755128672841, 36861.631383686894, 36886.0, 36967.0, 37001.0, 37371.25257494889, 54084.0, 54409.45590544044, 56415.71792141177, 56659.0, 57312.713436432554, 7890.526568405914, 8009.519428834288, 8273.475801694438, 8293.377996650395, 8417.0, 8692.174243446863, 11329.943350283196, 12157.69605759863, 12212.0, 12430.81353779676, 10012.249081318785, 11053.0, 11074.889251107386, 11235.269707468988, 11388.715282117682, 10592.735181620521, 10854.565817367216, 10883.619073332395, 10977.231593788678, 11015.669529914116, 9722.659706910224, 10142.949285253526, 10787.029167374974, 10850.186236032172, 10950.397728124712, 8536.725506752407, 8570.700025499078, 8602.440841345293, 8670.91329086701, 8779.253763429924, 10438.164946804389, 10782.24524283324, 10923.453827308762, 10925.508352124332, 10983.890161098607], "value": 8566.836138029883, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.3493970484612, 1498.258362110755, 1500.1299246437068, 1659.1123748794398, 1753.964920701586, 7876.488028278158, 8204.548749818758, 8231.835363292737, 8244.91755082449, 8253.422260441772, 8004.759857204293, 8152.714654987077, 8159.020917489895, 8179.550124743151, 8184.590770461483, 1952.9121189546504, 2014.8589598728095, 2020.8282296004784, 2278.2254033628524, 2307.238611258281, 2265.954680906381, 2338.53229354129, 2339.6256598944174, 2347.225415612852, 2349.859008459498, 2229.5429436965383, 2294.27730264966, 2295.276987748862, 2302.056156975632, 2303.6314189729646, 1911.4265720283997, 2007.4579863436863, 2015.3752336775647, 2017.3947815655317, 2240.809531189851, 2287.1880482428833, 2293.7247530296304, 2309.376468353552, 2310.202979971907, 2315.3632750993443, 8113.472624279462, 8159.020917489939, 8173.5504547249875, 8176.713815016446, 8183.918160818375, 4888.486708895586, 5068.265101560253, 5081.771320290596, 5104.234364845266, 5106.361704786902, 3247.594050743657, 3342.715869151125, 3441.380551500729, 3451.7928924264625, 3469.5663042119736, 1186.0985650905288, 1190.7380376317196, 1203.169812829145, 1208.4380762945273, 1221.291650842518, 11359.943200284028, 11374.090072794157, 11375.544978200862, 11378.943105284421, 11404.087672986141, 4410.757408342572, 4447.533009034069, 4637.884052898705, 4658.836940707059, 4659.930101048487, 8905.554722263862, 8961.417507861968, 8982.056884027214, 8990.056044115274, 9007.928176519437, 5053.393592768891, 5056.241563765465, 5075.746212689351, 5078.847634570969, 5091.1854103343285, 3853.9614603854166, 4642.3500709900645, 4720.480747117815, 4745.217039188564, 4772.642051846056, 3624.909377265537, 3630.528031355907, 3694.07648087978, 3729.8881033569037, 3767.6420740029653, 1137.988620113805, 1174.6652204121783, 1178.3460179600233, 1180.740237147826, 1193.0574845871838, 904.5432056811268, 953.93322467428, 965.4979410706393, 974.6637410093506, 997.870276864003, 5518.227448157261, 5541.778328866801, 5599.7480113394995, 5742.511886489695, 5820.039693450533, 414.65790722653327, 420.6025306085781, 434.7608815151654, 434.89997300621036, 441.633444241279, 3674.706023518112, 3698.593154752975, 3727.086863718352, 3772.7359084863797, 3772.86794962175, 9954.601815927426, 10316.381017138996, 10431.5827366906, 10481.004304591204, 10483.528241229164, 10324.690259292083, 10337.793244135075, 10339.327943683636, 10350.120239779702, 10351.689449316533, 7612.961935190399, 7861.960690196627, 7932.801679958047, 7940.0868900076075, 7966.561839098905, 5504.4495550444635, 5541.113421852484, 5636.718164091861, 5673.290838645169, 5719.399463056486, 9302.813943721223, 9326.160645541933, 9495.572699228413, 9612.807743845224, 9679.854802178113, 9415.152636262495, 9646.324757266924, 9739.172170365315, 9773.12041916231, 9797.804043919225, 6301.653409062362, 6727.764528241488, 6899.516603930179, 7017.578945263301, 7068.045813815274, 7974.840503189787, 8028.116907140093, 8048.396370272136, 8093.55485448306, 8104.108548059827, 6948.096747422803, 7088.113985751781, 7119.715211391486, 7209.6034718091005, 7246.6376681164675, 7092.822679433056, 7107.538010029331, 7181.533200341961, 7191.460640452092, 7208.026916366223, 6488.578242414228, 6601.768938087144, 6623.072769812326, 6624.105745724266, 6625.4699624029, 4814.446338671098, 4851.175300198904, 4955.925661115159, 4961.107000739901, 4989.9251511228085, 4847.95152048475, 4937.23472861707, 4990.0, 5020.121478741133, 5070.036693028313], "value": 4313.887660303052, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.8175244491752, 335.9109835893487, 338.25921232500815, 342.14463840399003, 346.60833258417983, 5634.464725851048, 5759.39526349733, 5762.452567006138, 5768.423157684229, 5769.076947688365, 5647.745851436685, 5661.745221465034, 5676.375598684142, 5685.943140568604, 5686.0902255639, 4149.709520333586, 4224.197402493516, 4394.5385734497895, 4417.42573465449, 4452.799624016927, 4410.404595379615, 4413.4041904342985, 4416.933745993812, 4427.0, 4428.734275943438, 4176.0, 4352.717073390236, 4360.389545463638, 4373.103513779683, 4379.671524635649, 4243.702940794145, 4258.467691538558, 4360.171567402183, 4387.846425375096, 4417.580329868657, 3860.1507668312925, 3873.2447172801317, 3883.0, 3891.6184754412343, 3891.747036442622, 5325.387580428262, 5424.783008679648, 5464.863378415532, 5480.342358916955, 5513.766924395626, 5075.390953085654, 5078.21287700407, 5078.390593128848, 5080.212567052113, 5085.898282034375, 5943.3165186003735, 5955.612885162451, 5968.462838344526, 5983.461488466015, 5995.640261584275, 4179.665626749883, 4264.0832221072305, 4270.316749320094, 4273.807678654468, 4275.358696195564, 6179.3820617937845, 6183.876322473526, 6216.222972128484, 6220.377962203788, 6232.0, 4368.453943257093, 4372.540883207281, 4378.671599630041, 4389.604935555815, 4402.911941761146, 4311.288637374861, 4421.214634780068, 4428.247197976351, 4434.091011342667, 4436.0, 5061.582756828094, 5065.809534759329, 5066.240063990431, 5073.518015788494, 5083.949160508421, 6007.909881351783, 6021.307549631849, 6030.7889223876955, 6046.879062418727, 6054.182685337511, 1495.7307684616874, 1527.5035613425682, 1549.333786471828, 1550.333356656626, 1553.6659618182146, 978.7846673731767, 1011.9797604048025, 1012.2661070723666, 1029.5264178477835, 1068.4817863336275, 5633.802816901471, 5684.914726279109, 5700.173474846124, 5703.258576385043, 5725.51333136688, 6033.698315084228, 6041.093835924647, 6059.1820104286235, 6095.8476038098515, 6099.9085013724825, 5512.200730894078, 5690.9146362804595, 5770.16332631766, 5778.566607504454, 5857.26784151981, 3292.7695061345476, 3324.6010478742705, 3333.93332133356, 3339.2653616204884, 3342.1477523231906, 6284.340144284784, 6349.142865713162, 6419.325970773095, 6477.255115661665, 6486.2216534016225, 6315.5263355247625, 6319.0, 6340.8414789629705, 6344.904826427607, 6346.397092276226, 6164.167837341902, 6381.361863813581, 6390.201224846895, 6414.358564143642, 6423.229212494531, 6198.72105755233, 6221.875562488815, 6225.782097626561, 6228.4705800007505, 6243.843903902439, 6121.908171377522, 6135.263768347827, 6144.938550614436, 6154.076888466766, 6187.7933802908, 6085.939140608537, 6392.680365981775, 6430.5177111715875, 6436.324185960594, 6458.61248325102, 4262.765547894772, 4262.914741705211, 4264.5309016007595, 4271.3165893458145, 4287.957120428756, 5956.434138756811, 6145.187169784835, 6181.443670069715, 6191.0, 6213.240989201468, 6028.0, 6058.607509555537, 6063.151158837854, 6072.0, 6073.665948372882, 5994.0, 6019.9465093609315, 6026.909596356146, 6027.30685971119, 6031.969840150771, 5713.857453346291, 5901.262342207224, 5910.822675319747, 5926.0, 5934.287885453773, 6050.122732203894, 6070.605410648293, 6073.635581865102, 6089.665068421102, 6096.573239873166, 5710.3154569401295, 5918.940810592011, 5948.702564871825, 5952.458287319038, 5955.940440595712], "value": 4556.965795363491, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.3437640499956, 767.5433117295214, 802.8273921106965, 841.1420351241734, 850.6427300533775, 12460.190087644296, 12722.936385318084, 12738.044646651504, 12739.235645861254, 14110.435582576685, 15060.322285497152, 15090.47183348583, 15100.471483498053, 15119.697606047872, 15123.31945062472, 656.9507286953474, 783.3693876429472, 799.3165843204049, 806.2662976691212, 811.5090370325956, 808.2685169921231, 810.1979040749645, 811.8335741173075, 812.252727490707, 812.4028838803474, 850.1456036683124, 851.1105894340399, 852.2925971443718, 852.8635418333037, 853.0999795216045, 679.7926632377123, 819.737683941139, 840.0129847429307, 840.6217202259008, 842.1199846160715, 614.5728718540616, 614.9631022138686, 615.2555407956378, 615.3999850146116, 615.722924683894, 13935.442582296697, 13944.0, 13988.300584970711, 14005.229712365815, 14009.089409188473, 13491.0, 14080.436782528686, 14114.153150810984, 14206.786898196535, 14317.427302907976, 11729.0, 11733.941330293379, 11744.706382340424, 11899.524019039229, 12015.93992030043, 3737.196502751894, 3755.0, 3759.2857357102334, 3831.67430768385, 3851.5185601799776, 56655.71672141613, 56917.0, 58367.416325836624, 58988.41011589915, 59202.11196832051, 10683.985021422952, 10819.026287633993, 10948.258366621723, 11021.559137634566, 11149.944250278697, 19137.61724765497, 19335.0, 19355.0, 19358.709619355723, 19359.3224237151, 7937.722179723682, 8156.34749220061, 8307.08622051574, 8429.199226073513, 8497.872531912026, 4449.599536041772, 4484.573965473275, 4801.207800712913, 4833.468318484964, 4908.312836202863, 3338.833058347073, 3358.0429577570276, 3408.113890388467, 3408.250184959305, 3412.505186747908, 536.3054843977059, 619.3806193806194, 635.5392340553062, 649.6004956951441, 663.8705452436728, 607.6414915200053, 613.6348872420903, 668.5119862500304, 744.5830335012411, 752.135044698601, 8845.380823342433, 9027.954860225656, 9424.905750942402, 9501.952490237505, 9683.370580912218, 633.9714712837933, 738.7599030315062, 747.3946103656056, 758.071362580834, 775.751759436986, 4008.659263962596, 4340.175366680321, 4388.956110438919, 4466.3523789050405, 4580.725156490621, 48980.51019489831, 49117.07063434917, 49959.0, 50036.49963500319, 50066.24900626494, 43870.600170920676, 47691.284630730566, 48788.26817597739, 48868.02263954772, 49726.25410618843, 42412.0, 43279.0, 43418.56581434208, 43856.56143438588, 46765.5323446768, 8924.464532128093, 9190.40262382943, 9229.676961306322, 9479.573419196015, 9521.476318802532, 29649.85175074111, 29651.40697186001, 30545.23636909006, 30701.0, 30819.075427737203, 37998.62001379951, 38092.80953595214, 38132.6186738129, 38307.42538861975, 38864.0, 11542.59600913964, 11718.179727419, 11861.110416718608, 11869.0, 12209.145359824726, 12915.095943283879, 13024.348782560644, 13112.803307950579, 13619.727605448034, 13764.518241861486, 12640.55758048464, 13116.737665246832, 13254.403551839998, 13368.131071480322, 13472.191668499921, 13049.543265985645, 13486.393112309774, 13499.257540835348, 13819.0, 13831.585052448443, 12879.0, 12967.0, 13481.528146515217, 13514.79727804064, 13525.0, 10510.894891050992, 10571.788564228826, 10819.783604328028, 11186.720331991766, 11675.708107297385, 10802.189835762507, 11126.777464450828, 11130.944345278222, 11333.716657083638, 11363.147763917905], "value": 6628.901142607832, "unit": "score"}], "name": "dromaeo_css", "value": 6909.317358434501, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 105.0, 110.0, 110.0, 112.0, 101.0, 111.0, 110.0, 111.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 127.0, 170.0, 187.0, 128.0, 158.0, 151.0, 128.0, 177.0, 135.0], "value": 152.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 160.0, 161.0, 159.0, 161.0, 161.0, 160.0, 160.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 127.0, 117.0, 76.0, 75.0, 75.0, 125.0, 109.0, 76.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 148.0, 93.0, 94.0, 93.0, 144.0, 93.0, 92.0, 145.0], "value": 108.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 58.0, 57.0, 58.0, 58.0, 58.0, 77.0, 57.0, 56.0], "value": 59.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 61.0, 61.0, 60.0, 62.0, 62.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 77.0, 79.0, 78.0, 78.0, 79.0, 88.0, 78.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 125.0, 125.0, 124.0, 123.0, 127.0, 126.0, 164.0, 131.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 170.0, 177.0, 174.0, 170.0, 165.0, 167.0, 167.0, 170.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 68.0, 67.0, 66.0, 68.0, 70.0, 67.0, 68.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1547.6000000000001, "alertThreshold": 2.0}]} 06:06:22 INFO - Return code: 0 06:06:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:06:22 ERROR - # TBPL SUCCESS # 06:06:22 INFO - Running post-action listener: _resource_record_post_action 06:06:22 INFO - Running post-run listener: _resource_record_post_run 06:06:23 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535883776; Read time: 12; Write time: 561336 06:06:23 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 251351040; Read time: 0; Write time: 364772 06:06:23 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284532736; Read time: 12; Write time: 196564 06:06:23 INFO - Running post-run listener: _upload_blobber_files 06:06:23 INFO - Blob upload gear active. 06:06:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:06:23 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 06:06:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:06:23 INFO - (blobuploader) - INFO - Open directory for files ... 06:06:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:06:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:06:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:24 INFO - (blobuploader) - INFO - Done attempting. 06:06:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:06:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:06:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:25 INFO - (blobuploader) - INFO - Done attempting. 06:06:25 INFO - (blobuploader) - INFO - Iteration through files over. 06:06:25 INFO - Return code: 0 06:06:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:06:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:06:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e7b6da467c1ca6382cf265e63d4ee7171d7b661ac9fbf69110ab0272e0d76bba056a9c35c19266a8be7c8e0c86872e62d139bcf6adb7b1c8843bf70d6fb438a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aab50d59ddc4522978e0e05791b202c16c449dbdf87bf72ee6faccb14a8d95113ff1002d9d0ca2fc6d070df42ba0ef7c57222d5e1e33b408df389a8027c78c57"} 06:06:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:06:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:06:25 INFO - Contents: 06:06:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e7b6da467c1ca6382cf265e63d4ee7171d7b661ac9fbf69110ab0272e0d76bba056a9c35c19266a8be7c8e0c86872e62d139bcf6adb7b1c8843bf70d6fb438a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aab50d59ddc4522978e0e05791b202c16c449dbdf87bf72ee6faccb14a8d95113ff1002d9d0ca2fc6d070df42ba0ef7c57222d5e1e33b408df389a8027c78c57"} 06:06:25 INFO - Running post-run listener: copy_logs_to_upload_dir 06:06:25 INFO - Copying logs to upload dir... 06:06:25 INFO - mkdir: /builds/slave/test/build/upload/logs 06:06:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.953729 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-24 06:06:24.589671) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 06:06:24.593416) ========= 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=32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e7b6da467c1ca6382cf265e63d4ee7171d7b661ac9fbf69110ab0272e0d76bba056a9c35c19266a8be7c8e0c86872e62d139bcf6adb7b1c8843bf70d6fb438a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aab50d59ddc4522978e0e05791b202c16c449dbdf87bf72ee6faccb14a8d95113ff1002d9d0ca2fc6d070df42ba0ef7c57222d5e1e33b408df389a8027c78c57"} build_url:https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/T0HvcPQ1RFiG382csapjYw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e7b6da467c1ca6382cf265e63d4ee7171d7b661ac9fbf69110ab0272e0d76bba056a9c35c19266a8be7c8e0c86872e62d139bcf6adb7b1c8843bf70d6fb438a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aab50d59ddc4522978e0e05791b202c16c449dbdf87bf72ee6faccb14a8d95113ff1002d9d0ca2fc6d070df42ba0ef7c57222d5e1e33b408df389a8027c78c57"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 06:06:24.617699) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 06:06:24.618038) ========= 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=32c5991c409366f7fec8a718000001d2-1461500781.907498-232844147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 06:06:24.701858) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 06:06:24.702173) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 06:06:24.702464) ========= ========= Total master_lag: 0.16 =========