builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1461592712.77 results: success (0) buildid: 20160425053553 builduid: 1d95cc054ffb4593add8611da7987a93 revision: 0f07f975526f3abda2f997bbb2feb0a25f771227 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 06:58:32.772370) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 06:58:32.772875) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 06:58:32.773197) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 06:58:32.789948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 06:58:32.790325) ========= 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=00204705a9daa57ed339a427000001b9-1461592625.283607-58725690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 06:58:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-04-25 06:58:32 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120389 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 06:58:32.925834) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 06:58:32.926327) ========= 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=00204705a9daa57ed339a427000001b9-1461592625.283607-58725690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017251 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 06:58:32.979235) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 06:58:32.979760) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0f07f975526f3abda2f997bbb2feb0a25f771227 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0f07f975526f3abda2f997bbb2feb0a25f771227 --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=00204705a9daa57ed339a427000001b9-1461592625.283607-58725690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 06:58:33,062 truncating revision to first 12 chars 2016-04-25 06:58:33,062 Setting DEBUG logging. 2016-04-25 06:58:33,062 attempt 1/10 2016-04-25 06:58:33,062 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0f07f975526f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 06:58:33,342 unpacking tar archive at: fx-team-0f07f975526f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.596259 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 06:58:33.589693) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 06:58:33.590054) ========= script_repo_revision: 0f07f975526f3abda2f997bbb2feb0a25f771227 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 06:58:33.590513) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 06:58:33.590811) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 06:58:33.635497) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-25 06:58:33.635927) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1461592625.283607-58725690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:58:33 INFO - MultiFileLogger online at 20160425 06:58:33 in /builds/slave/test 06:58:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:58:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:58:33 INFO - {'append_to_log': False, 06:58:33 INFO - 'base_work_dir': '/builds/slave/test', 06:58:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:58:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:58:33 INFO - 'branch': 'Fx-Team-Non-PGO', 06:58:33 INFO - 'buildbot_json_path': 'buildprops.json', 06:58:33 INFO - 'config_files': ('talos/linux_config.py',), 06:58:33 INFO - 'default_actions': ('clobber', 06:58:33 INFO - 'read-buildbot-config', 06:58:33 INFO - 'download-and-extract', 06:58:33 INFO - 'populate-webroot', 06:58:33 INFO - 'create-virtualenv', 06:58:33 INFO - 'install', 06:58:33 INFO - 'run-tests'), 06:58:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:58:33 INFO - 'download_minidump_stackwalk': True, 06:58:33 INFO - 'download_symbols': 'ondemand', 06:58:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:58:33 INFO - 'tooltool.py': '/tools/tooltool.py', 06:58:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:58:33 INFO - '/tools/misc-python/virtualenv.py')}, 06:58:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:58:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:58:33 INFO - 'installer_path': 'installer.exe', 06:58:33 INFO - 'log_level': 'info', 06:58:33 INFO - 'log_name': 'talos', 06:58:33 INFO - 'log_to_console': True, 06:58:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:58:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:58:33 INFO - 'opt_config_files': (), 06:58:33 INFO - 'pip_index': False, 06:58:33 INFO - 'sps_profile': False, 06:58:33 INFO - 'sps_profile_interval': 0, 06:58:33 INFO - 'suite': 'dromaeojs', 06:58:33 INFO - 'system_bits': '32', 06:58:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:58:33 INFO - 'title': 'talos-linux64-ix-016', 06:58:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:58:33 INFO - 'use_talos_json': True, 06:58:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:58:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:58:33 INFO - 'work_dir': 'build'} 06:58:33 INFO - ##### 06:58:33 INFO - ##### Running clobber step. 06:58:33 INFO - ##### 06:58:33 INFO - Running pre-action listener: _resource_record_pre_action 06:58:33 INFO - Running main action method: clobber 06:58:33 INFO - rmtree: /builds/slave/test/build 06:58:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:58:34 INFO - Running post-action listener: _resource_record_post_action 06:58:34 INFO - ##### 06:58:34 INFO - ##### Running read-buildbot-config step. 06:58:34 INFO - ##### 06:58:34 INFO - Running pre-action listener: _resource_record_pre_action 06:58:34 INFO - Running main action method: read_buildbot_config 06:58:34 INFO - Using buildbot properties: 06:58:34 INFO - { 06:58:34 INFO - "project": "", 06:58:34 INFO - "product": "firefox", 06:58:34 INFO - "script_repo_revision": "production", 06:58:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:58:34 INFO - "repository": "", 06:58:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:58:34 INFO - "buildid": "20160425053553", 06:58:34 INFO - "pgo_build": "False", 06:58:34 INFO - "basedir": "/builds/slave/test", 06:58:34 INFO - "buildnumber": 1601, 06:58:34 INFO - "slavename": "talos-linux64-ix-016", 06:58:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:58:34 INFO - "platform": "ubuntu64_hw", 06:58:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:58:34 INFO - "branch": "fx-team", 06:58:34 INFO - "repo_path": "integration/fx-team", 06:58:34 INFO - "revision": "0f07f975526f3abda2f997bbb2feb0a25f771227", 06:58:34 INFO - "stage_platform": "linux64", 06:58:34 INFO - "builduid": "1d95cc054ffb4593add8611da7987a93", 06:58:34 INFO - "slavebuilddir": "test" 06:58:34 INFO - } 06:58:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 06:58:34 INFO - Running post-action listener: _resource_record_post_action 06:58:34 INFO - ##### 06:58:34 INFO - ##### Running download-and-extract step. 06:58:34 INFO - ##### 06:58:34 INFO - Running pre-action listener: _resource_record_pre_action 06:58:34 INFO - Running main action method: download_and_extract 06:58:34 INFO - mkdir: /builds/slave/test/build/tests 06:58:34 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')]} 06:58:34 INFO - https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/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 06:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/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 06:58:35 INFO - Downloaded 1361 bytes. 06:58:35 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 06:58:35 INFO - Using the following test package requirements: 06:58:35 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:58:35 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:58:35 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:58:35 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:35 INFO - u'jsshell-linux-x86_64.zip'], 06:58:35 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:58:35 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 06:58:35 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:58:35 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:58:35 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:58:35 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:58:35 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:58: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')]} 06:58:35 INFO - https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:58:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:58:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:58:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/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 06:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/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 06:58:36 INFO - Downloaded 22288052 bytes. 06:58:36 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'] 06:58:36 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 06:58:37 INFO - Return code: 0 06:58:37 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 06:58:37 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')]} 06:58:37 INFO - https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 06:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/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 06:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/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 06:58:39 INFO - Downloaded 22288052 bytes. 06:58:39 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'] 06:58:39 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 06:58:40 INFO - Return code: 0 06:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:40 INFO - https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:58:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:58:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 06:58:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/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 06:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/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 06:58:42 INFO - Downloaded 10840145 bytes. 06:58:42 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'] 06:58:42 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 06:58:42 INFO - Return code: 0 06:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:42 INFO - https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:58:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:58:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:58:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/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 06:58:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/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 06:58:43 INFO - Downloaded 54814846 bytes. 06:58:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:58:43 INFO - mkdir: /builds/slave/test/properties 06:58:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:58:43 INFO - Writing to file /builds/slave/test/properties/build_url 06:58:43 INFO - Contents: 06:58:43 INFO - build_url:https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 06:58:44 INFO - Running post-action listener: _resource_record_post_action 06:58:44 INFO - Running post-action listener: set_extra_try_arguments 06:58:44 INFO - ##### 06:58:44 INFO - ##### Running populate-webroot step. 06:58:44 INFO - ##### 06:58:44 INFO - Running pre-action listener: _resource_record_pre_action 06:58:44 INFO - Running main action method: populate_webroot 06:58:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:58:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:58:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:58:44 INFO - '--tppagecycles', 06:58:44 INFO - '7'], 06:58:44 INFO - 'tests': ['tsvgm']}}, 06:58:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:58:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:58:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:58:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:58:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:58:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:58:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:44 INFO - 'talos_options': ['--disable-e10s'], 06:58:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:44 INFO - 'talos_options': ['--disable-e10s'], 06:58:44 INFO - 'tests': ['damp', 'tps']}, 06:58:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:44 INFO - 'tests': ['damp', 'tps']}, 06:58:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:58:44 INFO - 'tests': ['dromaeo_dom']}, 06:58:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:58:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:58:44 INFO - 'tests': ['a11yr', 06:58:44 INFO - 'ts_paint', 06:58:44 INFO - 'tpaint', 06:58:44 INFO - 'sessionrestore', 06:58:44 INFO - 'sessionrestore_no_auto_restore', 06:58:44 INFO - 'tabpaint']}, 06:58:44 INFO - 'other-e10s': {'tests': ['a11yr', 06:58:44 INFO - 'ts_paint', 06:58:44 INFO - 'tpaint', 06:58:44 INFO - 'sessionrestore', 06:58:44 INFO - 'sessionrestore_no_auto_restore', 06:58:44 INFO - 'tabpaint']}, 06:58:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:58:44 INFO - 'ts_paint', 06:58:44 INFO - 'tpaint', 06:58:44 INFO - 'sessionrestore', 06:58:44 INFO - 'sessionrestore_no_auto_restore', 06:58:44 INFO - 'tabpaint']}, 06:58:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:58:44 INFO - 'ts_paint', 06:58:44 INFO - 'tpaint', 06:58:44 INFO - 'sessionrestore', 06:58:44 INFO - 'sessionrestore_no_auto_restore', 06:58:44 INFO - 'tabpaint']}, 06:58:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:58:44 INFO - 'tests': ['a11yr', 06:58:44 INFO - 'ts_paint', 06:58:44 INFO - 'tpaint', 06:58:44 INFO - 'sessionrestore', 06:58:44 INFO - 'sessionrestore_no_auto_restore', 06:58:44 INFO - 'tabpaint']}, 06:58:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:58:44 INFO - 'tests': ['a11yr', 06:58:44 INFO - 'ts_paint', 06:58:44 INFO - 'tpaint', 06:58:44 INFO - 'sessionrestore', 06:58:44 INFO - 'sessionrestore_no_auto_restore', 06:58:44 INFO - 'tabpaint']}, 06:58:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:58:44 INFO - 'tests': ['tsvgx', 06:58:44 INFO - 'tsvgr_opacity', 06:58:44 INFO - 'tart', 06:58:44 INFO - 'tscrollx', 06:58:44 INFO - 'cart']}, 06:58:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:58:44 INFO - 'tsvgr_opacity', 06:58:44 INFO - 'tart', 06:58:44 INFO - 'tscrollx', 06:58:44 INFO - 'cart']}, 06:58:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:44 INFO - 'talos_options': ['--disable-e10s'], 06:58:44 INFO - 'tests': ['tp5o']}, 06:58:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:44 INFO - 'tests': ['tp5o']}, 06:58:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:44 INFO - 'talos_options': ['--disable-e10s', 06:58:44 INFO - '--xperf_path', 06:58:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:44 INFO - 'tests': ['tp5n']}, 06:58:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:44 INFO - 'talos_options': ['--xperf_path', 06:58:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:44 INFO - 'tests': ['tp5n']}}, 06:58:44 INFO - 'talos.zip': {'path': '', 06:58:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:58:44 INFO - Running post-action listener: _resource_record_post_action 06:58:44 INFO - ##### 06:58:44 INFO - ##### Running create-virtualenv step. 06:58:44 INFO - ##### 06:58:44 INFO - Running pre-action listener: _resource_record_pre_action 06:58:44 INFO - Running main action method: create_virtualenv 06:58:44 INFO - Creating virtualenv /builds/slave/test/build/venv 06:58:44 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 06:58:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:58:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:58:44 INFO - Using real prefix '/usr' 06:58:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:58:45 INFO - Installing distribute.............................................................................................................................................................................................done. 06:58:47 INFO - Installing pip.................done. 06:58:47 INFO - Return code: 0 06:58:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:58: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')]} 06:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:47 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 0x7f89cd0abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c640>, '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 0x210d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210d9d0>, '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': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', '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 06:58:47 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 06:58:47 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 06:58:47 INFO - Using env: {'DISPLAY': ':0', 06:58:47 INFO - 'HOME': '/home/cltbld', 06:58:47 INFO - 'LANG': 'en_US.UTF-8', 06:58:47 INFO - 'LANGUAGE': 'en_US:en', 06:58:47 INFO - 'LOGNAME': 'cltbld', 06:58:47 INFO - 'MAIL': '/var/mail/cltbld', 06:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:47 INFO - 'MOZ_NO_REMOTE': '1', 06:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:47 INFO - 'NO_EM_RESTART': '1', 06:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:47 INFO - 'PWD': '/builds/slave/test', 06:58:47 INFO - 'SHELL': '/bin/bash', 06:58:47 INFO - 'SHLVL': '1', 06:58:47 INFO - 'TERM': 'linux', 06:58:47 INFO - 'TMOUT': '86400', 06:58:47 INFO - 'USER': 'cltbld', 06:58:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', 06:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:47 INFO - '_': '/tools/buildbot/bin/python'} 06:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:47 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 06:58:47 INFO - Cleaning up... 06:58:47 INFO - Return code: 0 06:58:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:58: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')]} 06:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:47 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 0x7f89cd0abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c640>, '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 0x210d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210d9d0>, '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': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', '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 06:58:47 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 06:58:47 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 06:58:47 INFO - Using env: {'DISPLAY': ':0', 06:58:47 INFO - 'HOME': '/home/cltbld', 06:58:47 INFO - 'LANG': 'en_US.UTF-8', 06:58:47 INFO - 'LANGUAGE': 'en_US:en', 06:58:47 INFO - 'LOGNAME': 'cltbld', 06:58:47 INFO - 'MAIL': '/var/mail/cltbld', 06:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:47 INFO - 'MOZ_NO_REMOTE': '1', 06:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:47 INFO - 'NO_EM_RESTART': '1', 06:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:47 INFO - 'PWD': '/builds/slave/test', 06:58:47 INFO - 'SHELL': '/bin/bash', 06:58:47 INFO - 'SHLVL': '1', 06:58:47 INFO - 'TERM': 'linux', 06:58:47 INFO - 'TMOUT': '86400', 06:58:47 INFO - 'USER': 'cltbld', 06:58:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', 06:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:47 INFO - '_': '/tools/buildbot/bin/python'} 06:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:47 INFO - Downloading/unpacking psutil>=0.7.1 06:58:47 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 06:58:47 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 06:58:47 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 06:58:47 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 06:58:47 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 06:58:47 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 06:58:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:58:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:49 INFO - Installing collected packages: psutil 06:58:49 INFO - Running setup.py install for psutil 06:58:49 INFO - building 'psutil._psutil_linux' extension 06:58:49 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 06:58:49 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 06:58:49 INFO - building 'psutil._psutil_posix' extension 06:58:49 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 06:58:49 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 06:58:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:50 INFO - Successfully installed psutil 06:58:50 INFO - Cleaning up... 06:58:50 INFO - Return code: 0 06:58:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:50 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 0x7f89cd0abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c640>, '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 0x210d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210d9d0>, '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': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', '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 06:58:50 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 06:58:50 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 06:58:50 INFO - Using env: {'DISPLAY': ':0', 06:58:50 INFO - 'HOME': '/home/cltbld', 06:58:50 INFO - 'LANG': 'en_US.UTF-8', 06:58:50 INFO - 'LANGUAGE': 'en_US:en', 06:58:50 INFO - 'LOGNAME': 'cltbld', 06:58:50 INFO - 'MAIL': '/var/mail/cltbld', 06:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:50 INFO - 'MOZ_NO_REMOTE': '1', 06:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:50 INFO - 'NO_EM_RESTART': '1', 06:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:50 INFO - 'PWD': '/builds/slave/test', 06:58:50 INFO - 'SHELL': '/bin/bash', 06:58:50 INFO - 'SHLVL': '1', 06:58:50 INFO - 'TERM': 'linux', 06:58:50 INFO - 'TMOUT': '86400', 06:58:50 INFO - 'USER': 'cltbld', 06:58:50 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', 06:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:50 INFO - '_': '/tools/buildbot/bin/python'} 06:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:58:50 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 06:58:50 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 06:58:50 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 06:58:50 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 06:58:50 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 06:58:50 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 06:58:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:58:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:58:52 INFO - Installing collected packages: mozsystemmonitor 06:58:52 INFO - Running setup.py install for mozsystemmonitor 06:58:52 INFO - Successfully installed mozsystemmonitor 06:58:52 INFO - Cleaning up... 06:58:52 INFO - Return code: 0 06:58:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f89cd0abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c640>, '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 0x210d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210d9d0>, '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': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', '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 06:58:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:58:52 INFO - Using env: {'DISPLAY': ':0', 06:58:52 INFO - 'HOME': '/home/cltbld', 06:58:52 INFO - 'LANG': 'en_US.UTF-8', 06:58:52 INFO - 'LANGUAGE': 'en_US:en', 06:58:52 INFO - 'LOGNAME': 'cltbld', 06:58:52 INFO - 'MAIL': '/var/mail/cltbld', 06:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:52 INFO - 'MOZ_NO_REMOTE': '1', 06:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:52 INFO - 'NO_EM_RESTART': '1', 06:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:52 INFO - 'PWD': '/builds/slave/test', 06:58:52 INFO - 'SHELL': '/bin/bash', 06:58:52 INFO - 'SHLVL': '1', 06:58:52 INFO - 'TERM': 'linux', 06:58:52 INFO - 'TMOUT': '86400', 06:58:52 INFO - 'USER': 'cltbld', 06:58:52 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', 06:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:52 INFO - '_': '/tools/buildbot/bin/python'} 06:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:52 INFO - Downloading/unpacking blobuploader==1.2.4 06:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:54 INFO - Downloading blobuploader-1.2.4.tar.gz 06:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:58:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:58:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:55 INFO - Downloading docopt-0.6.1.tar.gz 06:58:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:58:55 INFO - Installing collected packages: blobuploader, requests, docopt 06:58:55 INFO - Running setup.py install for blobuploader 06:58:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:58:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:58:55 INFO - Running setup.py install for requests 06:58:55 INFO - Running setup.py install for docopt 06:58:55 INFO - Successfully installed blobuploader requests docopt 06:58:55 INFO - Cleaning up... 06:58:55 INFO - Return code: 0 06:58:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:55 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')]} 06:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:55 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')]} 06:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:55 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 0x7f89cd0abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c640>, '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 0x210d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210d9d0>, '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': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', '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 06:58:55 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 06:58:55 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 06:58:55 INFO - Using env: {'DISPLAY': ':0', 06:58:55 INFO - 'HOME': '/home/cltbld', 06:58:55 INFO - 'LANG': 'en_US.UTF-8', 06:58:55 INFO - 'LANGUAGE': 'en_US:en', 06:58:55 INFO - 'LOGNAME': 'cltbld', 06:58:55 INFO - 'MAIL': '/var/mail/cltbld', 06:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:55 INFO - 'MOZ_NO_REMOTE': '1', 06:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:55 INFO - 'NO_EM_RESTART': '1', 06:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:55 INFO - 'PWD': '/builds/slave/test', 06:58:55 INFO - 'SHELL': '/bin/bash', 06:58:55 INFO - 'SHLVL': '1', 06:58:55 INFO - 'TERM': 'linux', 06:58:55 INFO - 'TMOUT': '86400', 06:58:55 INFO - 'USER': 'cltbld', 06:58:55 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', 06:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:55 INFO - '_': '/tools/buildbot/bin/python'} 06:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:55 INFO - Running setup.py (path:/tmp/pip-xClXgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:56 INFO - Running setup.py (path:/tmp/pip-mwGUhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:56 INFO - Running setup.py (path:/tmp/pip-7rAiWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:56 INFO - Running setup.py (path:/tmp/pip-LgLLIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:56 INFO - Running setup.py (path:/tmp/pip-hqgo6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:56 INFO - Running setup.py (path:/tmp/pip-rY3qqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:56 INFO - Running setup.py (path:/tmp/pip-KmKGnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:56 INFO - Running setup.py (path:/tmp/pip-tYkg06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:56 INFO - Running setup.py (path:/tmp/pip-VRz3Jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:56 INFO - Running setup.py (path:/tmp/pip-jmHWij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:56 INFO - Running setup.py (path:/tmp/pip-15eYXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:56 INFO - Running setup.py (path:/tmp/pip-4liLaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:56 INFO - Running setup.py (path:/tmp/pip-6U8RAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:56 INFO - Running setup.py (path:/tmp/pip-7DgnkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:56 INFO - Running setup.py (path:/tmp/pip-eNGuCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:57 INFO - Running setup.py (path:/tmp/pip-VBTj7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:57 INFO - Running setup.py (path:/tmp/pip-VVGJ1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:58:57 INFO - Running setup.py install for manifestparser 06:58:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:58:57 INFO - Running setup.py install for mozcrash 06:58:57 INFO - Running setup.py install for mozdebug 06:58:57 INFO - Running setup.py install for mozdevice 06:58:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:58:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:58:57 INFO - Running setup.py install for mozfile 06:58:57 INFO - Running setup.py install for mozhttpd 06:58:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:58:57 INFO - Running setup.py install for mozinfo 06:58:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:58:57 INFO - Running setup.py install for mozInstall 06:58:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:58:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:58:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:58:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:58:57 INFO - Running setup.py install for mozleak 06:58:58 INFO - Running setup.py install for mozlog 06:58:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:58:58 INFO - Running setup.py install for moznetwork 06:58:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:58:58 INFO - Running setup.py install for mozprocess 06:58:58 INFO - Running setup.py install for mozprofile 06:58:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:58:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:58:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:58:58 INFO - Running setup.py install for mozrunner 06:58:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:58:58 INFO - Running setup.py install for mozscreenshot 06:58:58 INFO - Running setup.py install for moztest 06:58:58 INFO - Running setup.py install for mozversion 06:58:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:58:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:58:58 INFO - Cleaning up... 06:58:58 INFO - Return code: 0 06:58:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58: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')]} 06:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:58 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 0x7f89cd0abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c640>, '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 0x210d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210d9d0>, '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': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', '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 06:58:58 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 06:58:58 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 06:58:58 INFO - Using env: {'DISPLAY': ':0', 06:58:58 INFO - 'HOME': '/home/cltbld', 06:58:58 INFO - 'LANG': 'en_US.UTF-8', 06:58:58 INFO - 'LANGUAGE': 'en_US:en', 06:58:58 INFO - 'LOGNAME': 'cltbld', 06:58:58 INFO - 'MAIL': '/var/mail/cltbld', 06:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:58 INFO - 'MOZ_NO_REMOTE': '1', 06:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:58 INFO - 'NO_EM_RESTART': '1', 06:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:58 INFO - 'PWD': '/builds/slave/test', 06:58:58 INFO - 'SHELL': '/bin/bash', 06:58:58 INFO - 'SHLVL': '1', 06:58:58 INFO - 'TERM': 'linux', 06:58:58 INFO - 'TMOUT': '86400', 06:58:58 INFO - 'USER': 'cltbld', 06:58:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', 06:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:58 INFO - '_': '/tools/buildbot/bin/python'} 06:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:59 INFO - Running setup.py (path:/tmp/pip-d5Xzcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:59 INFO - Running setup.py (path:/tmp/pip-Bx4Zkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:59 INFO - Running setup.py (path:/tmp/pip-sF4SDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:59 INFO - Running setup.py (path:/tmp/pip-Xl6y3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:59 INFO - Running setup.py (path:/tmp/pip-Tgmd5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:59 INFO - Running setup.py (path:/tmp/pip-w2VCZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:59 INFO - Running setup.py (path:/tmp/pip-q7DDBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:59 INFO - Running setup.py (path:/tmp/pip-3tUCTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:59 INFO - Running setup.py (path:/tmp/pip-9AE9JF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:59 INFO - Running setup.py (path:/tmp/pip-kUcE30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:59 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)) 06:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:59 INFO - Running setup.py (path:/tmp/pip-ktBlxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:59:00 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)) 06:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:59:00 INFO - Running setup.py (path:/tmp/pip-s37uGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:59:00 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)) 06:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:59:00 INFO - Running setup.py (path:/tmp/pip-GgIPoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:59:00 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)) 06:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:59:00 INFO - Running setup.py (path:/tmp/pip-lB2tW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:59:00 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)) 06:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:00 INFO - Running setup.py (path:/tmp/pip-nz8Xhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:00 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)) 06:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:59:00 INFO - Running setup.py (path:/tmp/pip-bIaDjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:59:00 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)) 06:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:59:00 INFO - Running setup.py (path:/tmp/pip-jUGqu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:59:00 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)) 06:59:00 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)) 06:59:00 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)) 06:59:00 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)) 06:59:00 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)) 06:59:00 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)) 06:59:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:02 INFO - Downloading blessings-1.6.tar.gz 06:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:59:02 INFO - Installing collected packages: blessings 06:59:02 INFO - Running setup.py install for blessings 06:59:02 INFO - Successfully installed blessings 06:59:02 INFO - Cleaning up... 06:59:02 INFO - Return code: 0 06:59:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:59:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:59:02 INFO - Reading from file tmpfile_stdout 06:59:02 INFO - Current package versions: 06:59:02 INFO - argparse == 1.2.1 06:59:02 INFO - blessings == 1.6 06:59:02 INFO - blobuploader == 1.2.4 06:59:02 INFO - docopt == 0.6.1 06:59:02 INFO - manifestparser == 1.1 06:59:02 INFO - mozInstall == 1.12 06:59:02 INFO - mozcrash == 0.17 06:59:02 INFO - mozdebug == 0.1 06:59:02 INFO - mozdevice == 0.48 06:59:02 INFO - mozfile == 1.2 06:59:02 INFO - mozhttpd == 0.7 06:59:02 INFO - mozinfo == 0.9 06:59:02 INFO - mozleak == 0.1 06:59:02 INFO - mozlog == 3.1 06:59:02 INFO - moznetwork == 0.27 06:59:02 INFO - mozprocess == 0.22 06:59:02 INFO - mozprofile == 0.28 06:59:02 INFO - mozrunner == 6.11 06:59:02 INFO - mozscreenshot == 0.1 06:59:02 INFO - mozsystemmonitor == 0.0 06:59:02 INFO - moztest == 0.7 06:59:02 INFO - mozversion == 1.4 06:59:02 INFO - psutil == 3.1.1 06:59:02 INFO - requests == 1.2.3 06:59:02 INFO - wsgiref == 0.1.2 06:59:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:02 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 0x7f89cd0abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c640>, '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 0x210d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210d9d0>, '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': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', '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 06:59:02 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 06:59:02 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 06:59:02 INFO - Using env: {'DISPLAY': ':0', 06:59:02 INFO - 'HOME': '/home/cltbld', 06:59:02 INFO - 'LANG': 'en_US.UTF-8', 06:59:02 INFO - 'LANGUAGE': 'en_US:en', 06:59:02 INFO - 'LOGNAME': 'cltbld', 06:59:02 INFO - 'MAIL': '/var/mail/cltbld', 06:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:02 INFO - 'MOZ_NO_REMOTE': '1', 06:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:02 INFO - 'NO_EM_RESTART': '1', 06:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:02 INFO - 'PWD': '/builds/slave/test', 06:59:02 INFO - 'SHELL': '/bin/bash', 06:59:02 INFO - 'SHLVL': '1', 06:59:02 INFO - 'TERM': 'linux', 06:59:02 INFO - 'TMOUT': '86400', 06:59:02 INFO - 'USER': 'cltbld', 06:59:02 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', 06:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:02 INFO - '_': '/tools/buildbot/bin/python'} 06:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:02 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)) 06:59:02 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)) 06:59:02 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)) 06:59:02 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)) 06:59:02 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)) 06:59:02 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)) 06:59:02 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)) 06:59:02 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)) 06:59:02 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)) 06:59:02 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)) 06:59:02 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)) 06:59:02 INFO - Cleaning up... 06:59:02 INFO - Return code: 0 06:59:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89cd0abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c640>, '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 0x210d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210d9d0>, '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': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', '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 06:59:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:59:02 INFO - Using env: {'DISPLAY': ':0', 06:59:02 INFO - 'HOME': '/home/cltbld', 06:59:02 INFO - 'LANG': 'en_US.UTF-8', 06:59:02 INFO - 'LANGUAGE': 'en_US:en', 06:59:02 INFO - 'LOGNAME': 'cltbld', 06:59:02 INFO - 'MAIL': '/var/mail/cltbld', 06:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:02 INFO - 'MOZ_NO_REMOTE': '1', 06:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:02 INFO - 'NO_EM_RESTART': '1', 06:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:02 INFO - 'PWD': '/builds/slave/test', 06:59:02 INFO - 'SHELL': '/bin/bash', 06:59:02 INFO - 'SHLVL': '1', 06:59:02 INFO - 'TERM': 'linux', 06:59:02 INFO - 'TMOUT': '86400', 06:59:02 INFO - 'USER': 'cltbld', 06:59:02 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', 06:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:02 INFO - '_': '/tools/buildbot/bin/python'} 06:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:03 INFO - Downloading/unpacking jsonschema 06:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:59:05 INFO - Downloading/unpacking functools32 (from jsonschema) 06:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:05 INFO - Downloading functools32-3.2.3-2.tar.gz 06:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:59:05 INFO - warning: no files found matching '*.txt' 06:59:05 INFO - no previously-included directories found matching 'build' 06:59:05 INFO - no previously-included directories found matching 'dist' 06:59:05 INFO - no previously-included directories found matching '.git*' 06:59:05 INFO - Installing collected packages: jsonschema, functools32 06:59:05 INFO - Running setup.py install for functools32 06:59:05 INFO - warning: no files found matching '*.txt' 06:59:05 INFO - no previously-included directories found matching 'build' 06:59:05 INFO - no previously-included directories found matching 'dist' 06:59:05 INFO - no previously-included directories found matching '.git*' 06:59:05 INFO - Successfully installed jsonschema functools32 06:59:05 INFO - Cleaning up... 06:59:05 INFO - Return code: 0 06:59:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:05 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 0x7f89cd0abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207d7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c640>, '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 0x210d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210d9d0>, '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': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', '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 06:59:05 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 06:59:05 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 06:59:05 INFO - Using env: {'DISPLAY': ':0', 06:59:05 INFO - 'HOME': '/home/cltbld', 06:59:05 INFO - 'LANG': 'en_US.UTF-8', 06:59:05 INFO - 'LANGUAGE': 'en_US:en', 06:59:05 INFO - 'LOGNAME': 'cltbld', 06:59:05 INFO - 'MAIL': '/var/mail/cltbld', 06:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:05 INFO - 'MOZ_NO_REMOTE': '1', 06:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:05 INFO - 'NO_EM_RESTART': '1', 06:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:05 INFO - 'PWD': '/builds/slave/test', 06:59:05 INFO - 'SHELL': '/bin/bash', 06:59:05 INFO - 'SHLVL': '1', 06:59:05 INFO - 'TERM': 'linux', 06:59:05 INFO - 'TMOUT': '86400', 06:59:05 INFO - 'USER': 'cltbld', 06:59:05 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', 06:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:05 INFO - '_': '/tools/buildbot/bin/python'} 06:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:05 INFO - Downloading/unpacking flake8 06:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:59:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:59:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:59:08 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 06:59:08 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 06:59:08 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 06:59:08 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 06:59:08 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 06:59:08 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 06:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:59:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:59:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:59:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:59:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:59:08 INFO - no previously-included directories found matching 'docs/_build' 06:59:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:59:08 INFO - Running setup.py install for pep8 06:59:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:59:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:59:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:59:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:59:08 INFO - no previously-included directories found matching 'docs/_build' 06:59:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:59:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:59:08 INFO - Cleaning up... 06:59:08 INFO - Return code: 0 06:59:08 INFO - Running post-action listener: _resource_record_post_action 06:59:08 INFO - Running post-action listener: _start_resource_monitoring 06:59:08 INFO - Starting resource monitoring. 06:59:08 INFO - ##### 06:59:08 INFO - ##### Running install step. 06:59:08 INFO - ##### 06:59:08 INFO - Running pre-action listener: _resource_record_pre_action 06:59:08 INFO - Running main action method: install 06:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:59:08 INFO - Reading from file tmpfile_stdout 06:59:08 INFO - Detecting whether we're running mozinstall >=1.0... 06:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:59:08 INFO - Reading from file tmpfile_stdout 06:59:08 INFO - Output received: 06:59:08 INFO - Usage: mozinstall [options] installer 06:59:08 INFO - Options: 06:59:08 INFO - -h, --help show this help message and exit 06:59:08 INFO - -d DEST, --destination=DEST 06:59:08 INFO - Directory to install application into. [default: 06:59:08 INFO - "/builds/slave/test"] 06:59:08 INFO - --app=APP Application being installed. [default: firefox] 06:59:08 INFO - mkdir: /builds/slave/test/build/application 06:59:08 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'] 06:59:08 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 06:59:24 INFO - Reading from file tmpfile_stdout 06:59:24 INFO - Output received: 06:59:24 INFO - /builds/slave/test/build/application/firefox/firefox 06:59:24 INFO - Running post-action listener: _resource_record_post_action 06:59:24 INFO - ##### 06:59:24 INFO - ##### Running run-tests step. 06:59:24 INFO - ##### 06:59:24 INFO - Running pre-action listener: _resource_record_pre_action 06:59:24 INFO - Running main action method: run_tests 06:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:59:24 INFO - Python 2.7.3 06:59:24 INFO - Return code: 0 06:59:24 INFO - grabbing minidump binary from tooltool 06:59: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')]} 06:59:24 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 0x210c640>, '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 0x210d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210d9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:59:24 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 06:59:24 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 06:59:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:59:24 INFO - Return code: 0 06:59:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:59:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:59:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:59:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:59:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:59:25 INFO - Return code: 0 06:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 06:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 06:59:25 INFO - Using env: {'DISPLAY': ':0', 06:59:25 INFO - 'HOME': '/home/cltbld', 06:59:25 INFO - 'LANG': 'en_US.UTF-8', 06:59:25 INFO - 'LANGUAGE': 'en_US:en', 06:59:25 INFO - 'LOGNAME': 'cltbld', 06:59:25 INFO - 'MAIL': '/var/mail/cltbld', 06:59:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:59:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:25 INFO - 'MOZ_NO_REMOTE': '1', 06:59:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:25 INFO - 'NO_EM_RESTART': '1', 06:59:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:25 INFO - 'PWD': '/builds/slave/test', 06:59:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:59:25 INFO - 'SHELL': '/bin/bash', 06:59:25 INFO - 'SHLVL': '1', 06:59:25 INFO - 'TERM': 'linux', 06:59:25 INFO - 'TMOUT': '86400', 06:59:25 INFO - 'USER': 'cltbld', 06:59:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461592625.283607-58725690', 06:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:25 INFO - '_': '/tools/buildbot/bin/python'} 06:59:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 06:59:25 INFO - mozversion application_buildid: 20160425053553 06:59:25 INFO - mozversion application_changeset: 0f07f975526f3abda2f997bbb2feb0a25f771227 06:59:25 INFO - mozversion application_display_name: Nightly 06:59:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:59:25 INFO - mozversion application_name: Firefox 06:59:25 INFO - mozversion application_remotingname: firefox 06:59:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:59:25 INFO - mozversion application_vendor: Mozilla 06:59:25 INFO - mozversion application_version: 48.0a1 06:59:25 INFO - mozversion platform_buildid: 20160425053553 06:59:25 INFO - mozversion platform_changeset: 0f07f975526f3abda2f997bbb2feb0a25f771227 06:59:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:59:25 INFO - mozversion platform_version: 48.0a1 06:59:25 INFO - using testdate: 1461592765 06:59:25 INFO - actual date: 1461592765 06:59:25 INFO - starting webserver on 'localhost:41142' 06:59:25 INFO - SUITE-START | Running 2 tests 06:59:25 INFO - TEST-START | dromaeo_css 06:59:25 INFO - operating with platform_type : linux_ 06:59:25 INFO - Initialising browser for dromaeo_css test... 06:59:25 INFO - TEST-INFO | started process 21095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLKszWZ/profile http://localhost:41142/getInfo.html) 06:59:30 INFO - PROCESS | 21095 | __metrics Screen width/height:1600/1200 06:59:30 INFO - PROCESS | 21095 | colorDepth:24 06:59:30 INFO - PROCESS | 21095 | Browser inner width/height: 1024/697 06:59:30 INFO - PROCESS | 21095 | __metrics 06:59:31 ERROR - PROCESS | 21095 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:59:32 INFO - TEST-INFO | 21095: exit 0 06:59:32 INFO - Browser initialized. 06:59:32 INFO - Running cycle 1/1 for dromaeo_css test... 06:59:32 INFO - TEST-INFO | started process 21176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLKszWZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:59:44 INFO - PROCESS | 21176 | RSS: Main: 156438528 06:59:44 INFO - PROCESS | 21176 | 07:00:35 INFO - PROCESS | 21176 | 1461592835636 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] 07:02:47 INFO - PROCESS | 21176 | Cycle 1(1): loaded http://localhost:41142/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41142/tests/dromaeo/cssquery-ext.html) 07:02:48 INFO - PROCESS | 21176 | RSS: Main: 255770624 07:02:48 INFO - PROCESS | 21176 | 07:05:50 INFO - PROCESS | 21176 | Cycle 1(1): loaded http://localhost:41142/tests/dromaeo/cssquery-ext.html (next: http://localhost:41142/tests/dromaeo/cssquery-jquery.html) 07:05:51 INFO - PROCESS | 21176 | RSS: Main: 231014400 07:05:51 INFO - PROCESS | 21176 | 07:08:53 INFO - PROCESS | 21176 | Cycle 1(1): loaded http://localhost:41142/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41142/tests/dromaeo/cssquery-mootools.html) 07:08:54 INFO - PROCESS | 21176 | RSS: Main: 238993408 07:08:54 INFO - PROCESS | 21176 | 07:11:56 INFO - PROCESS | 21176 | Cycle 1(1): loaded http://localhost:41142/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41142/tests/dromaeo/cssquery-prototype.html) 07:11:56 INFO - PROCESS | 21176 | RSS: Main: 228196352 07:11:56 INFO - PROCESS | 21176 | 07:14:59 INFO - PROCESS | 21176 | Cycle 1(1): loaded http://localhost:41142/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41142/tests/dromaeo/cssquery-yui.html) 07:15:00 INFO - PROCESS | 21176 | RSS: Main: 216731648 07:15:00 INFO - PROCESS | 21176 | 07:18:03 INFO - PROCESS | 21176 | Cycle 1(1): loaded http://localhost:41142/tests/dromaeo/cssquery-yui.html (next: http://localhost:41142/tests/dromaeo/cssquery-dojo.html) 07:18:03 INFO - PROCESS | 21176 | RSS: Main: 276328448 07:18:03 INFO - PROCESS | 21176 | 07:18:03 INFO - PROCESS | 21176 | __start_tp_report 07:18:03 INFO - PROCESS | 21176 | _x_x_mozilla_page_load 07:18:03 INFO - PROCESS | 21176 | _x_x_mozilla_page_load_details 07:18:03 INFO - PROCESS | 21176 | |i|pagename|runs| 07:18:03 INFO - PROCESS | 21176 | |0;dojo.html;2640.84154950703;2706.936462324394;2708.377073273148;2716.945661086777;2736.329599248184;4656.138614356347;4669.299605059243;4708.0819240248165;4714.740689262094;4755.048990201956;4699.248120300753;4761.238201887699;4768.356271903292;4819.662623616348;4852.58753005994;4316.913661726763;4320.416743739602;4358.0848021915435;4380.846670366538;4469.776511174445;4405.096955124208;4421.668374871898;4432.645388368939;4476.932846007313;4480.955190448087;4285.957140428587;4336.56634336567;4372.300431930876;4378.605925466692;4414.690971631987;4309.1381723655395;4344.587264209895;4349.934750978738;4359.193549193409;4406.4271644686305;4343.109662519208;4378.343248512749;4386.34204869269;4397.428334316518;4422.248217802981;4426.136903303857;4465.062336909253;4598.2642777155825;4614.238650622643;4697.177993851063;5072.898542029138;5079.466656001104;5085.872853178663;5086.54221120101;5113.437521872591;5100.9489905100845;5111.105556527593;5118.539331460186;5122.231665250205;5131.666441681279;4646.210144275515;4705.55297246761;4742.359781429497;4796.736179510161;4804.663673542888;5178.922316165261;5192.870178245574;5194.039102766001;5201.817936372209;5204.245384419238;4968.403791545038;4979.3277907482025;4981.875453113701;4994.750262486861;5025.070361983045;4915.0415668944215;5031.572316353151;5093.821716239914;5135.229715542699;5142.794288228504;4996.625253105959;5029.245613158056;5030.320906677625;5039.143345631252;5088.72012039334;4833.564979151823;5000.2499625056535;5001.099802035668;5011.1481048221885;5018.5232402921665;4200.558941311179;4219.915601687949;4289.270823959934;4297.05464797744;4299.204647140289;3728.993171843587;3738.0467980664757;3745.138618117848;3765.1340191755503;3773.094457330276;4410.963423595453;4417.514073451917;4425.22558552252;4460.929376949509;4463.330500424962;5000.349954505891;5036.420811606639;5082.466341034138;5113.539781419616;5157.303763991888;4425.247707889666;4435.667324950641;4452.220861349316;4455.888602784957;4463.419755431838;4584.862454126382;4586.197415452282;4587.128445595326;4592.334111553872;4634.351190833286;4631.467381251199;4777.402824646919;4811.230203167476;4818.951810481921;4854;5094.388673359221;5103.413107492686;5109.642325037212;5112.182050871843;5138.845834624967;4801.279808028684;4803.327534145153;4806.399200099988;4812.831550895702;4841.080194762983;4869.732164730974;4942.57988071018;4943.159662857395;5003.77483013258;5061.038402703622;5064.290999260033;5086.440491546001;5110.310108135503;5114.667546609458;5119.104156772624;4921.557059864629;4925.310456536016;4927.507249275044;4931.3096166536;4972;4922.335484709519;4922.581580565548;4929.063477939323;4931.3835770528685;4989.625778066587;4742.596879265301;4856.053069651384;4922.187839006524;4966.279889416087;4972.477889821661;4934.654574179773;4954.133026720381;4956.752162391938;4958.950410495993;5014.974925125351;4754.120487709784;4834.299026641047;4837.153498137882;4865.391826021747;4924.359833221658 07:18:03 INFO - PROCESS | 21176 | |1;ext.html;585.259646547118;604.4167378479766;621.9253689557254;626.5301024231825;631.3844002097952;27154.592681109774;34632.307353852906;34816.30367392651;34934.65065349346;35280.294394112105;36470;37138.257234855286;37184;37248;37314.44028339571;7198.280171982786;7525.096988361404;7736.729214477495;7740.303372696456;7751.418643601724;9305.209057230144;9595.952020239924;9599.760005999837;9610.231181505464;9617.086376794194;9652.324337296392;9822.508874556244;9835.557399917021;9836.803263934717;9837.852432213522;9633.27750418718;9700.951495242478;9748.512574371252;9751.463669498175;9772.071653192936;9553.379030363074;9659.275554333453;9663.516824158763;9667.468289244089;9931.652392166312;36103.09742256438;36638.450423243674;36780.632193677986;36782.63217367819;36856.26287474262;2906.89825856094;2918.751906087985;2937.3390987027747;3183.2360233544014;3660.6156353583024;27939.58090628642;28251.82231947911;28311.716882831115;28907.855460722563;29343.413131737245;3251.252211991255;3253.995171877185;3269.820159891205;3293.2096296888813;3367.3433680432327;235904;237169.81415092986;237451;237584;237846;49575;50040;50060;50174;50208.49791502038;52616;52656.47343526516;52672.73663631657;52982.470175297756;53030.204546931825;13702.65743356424;13960.650983725489;13979.440822367194;14113.08264962774;14115.153090814583;10695.83956240657;10743.570257189625;10749.355038697704;10756.731081722863;10761.946190268998;15110.320035598425;15526.844731552766;15555.377784888478;15582.298796554182;15584.14567766841;5579.609427340129;5581.920452388307;5742.425757424307;5783.392743761844;5783.583022159513;792.4096548071608;833.2417500074903;873.5501216873315;892.723255790694;960.5053397500293;26276.605850912252;27851.164465066082;28143.43713125767;28234;28237.43525129486;952.1620973543238;963.5952899782109;966.8936416994125;1010.0656892374524;1058.9841152382721;14732.312239151586;14861.182634954965;14869.851301486846;15227;15286.770698439532;309673;311319;315652;315692;316048;48433.5156648436;48479;48698.5130148694;48761;48805.511944880804;1002.904724051214;1074.6990842564094;1199.7120691034088;1205.39127740494;1264.121435602266;25422.618660720473;26783.86608066947;28674.856625717573;28730.569041464812;28806.279843004093;40368;40442.79778601088;40831.38752918649;40848.1830363397;40868.59131408648;233773;241477;243115;243321;243628;33744.15639609029;34414.31171376609;34449.48325775166;34454.31091378108;34502.51467309234;35591.64408355884;36418.81790591136;36525.63474365223;36793.448098279085;37225;30806.845965770026;30835.32267147809;31666.366672665958;32081.55632996474;32540.186495337806;33657.83171084129;33763.48064337062;33977.66022339745;34104.65895341114;34293.31413371669;33924.83037584895;34575;34598;34615;34918;30225.244368890955;31367.843160784963;31378.372432550765;31542.684573154893;31611.36777264396;23970.88014559916;24398.634020490063;24430.63354049655;24799.50400992006;24880.25359239226 07:18:03 INFO - PROCESS | 21176 | |2;jquery.html;373.49391574416666;381.11961369237065;381.7041792610726;388.6385661334959;400.7535365750065;15551.44352255317;17109.57226069349;17670;17969.19138638761;18010.5497362566;16605.08672023038;16918.915405422988;17214.82785172148;17471.475855724348;17479.737803932952;5014.72419016953;5134.1528647773075;5167.6641018333685;5174.948250517503;5181.6113791465605;3645.052286405527;5576.525995290405;5870;5870.20752198452;5902.763889444439;5787.971060144693;5810.912836307459;5813.01178799603;5844.736986835582;5888.116782482641;5765.740541675614;5944.910826337608;5962.791302304442;5965.4929331006915;5973.163757073991;3325.1687078230443;5019.19692849146;5232.2674825524455;5265.420803711589;5291.206319052135;19851.908145052017;20038.298659546846;20581.176752929863;20743.681011038312;20791.480212994644;1612.3308826836849;1738.3133662203486;1950.8634395592314;1978.169168949045;2016.9697454538193;8801.735947921572;9054.954725226398;9116.58975346111;9187.862182067207;9452.621895124186;1619.0771260381587;1662.3184494357256;1708.8034875989297;1768.929242830298;1775.1922875091932;66502.66748666274;67318.3268167317;67328;67474;69342.65328673375;9838.950805245928;9850.704478865646;9879.209663226924;10017.14854237398;10142.949285253526;13769;13846.376913038937;13879.791803122962;13922.721545569031;13947.930260348836;6988.965055174794;7045.542039767399;7080.575165490087;7156.532910753387;7165.390941769903;6401.967990160019;6408.935910640927;6420.518461115342;6448.774292899726;6614.470842332602;4276.764777937244;4380.233459144701;4393.472783266028;4447.62195213404;4465.754383508938;1687.9493615191564;1788.5691446842734;1792.7042038063835;1862.01625790313;1863.2826361850514;763.6220071064747;811.7970507373157;848.7453763870814;894.4677916639589;968.9176420004237;16127.596810079607;16482.58793530171;16904.661906761798;16991.40530081441;17220.913895430444;821.4947807098711;848.1137211613878;850.6937502499095;874.5321253129545;905.2576886952767;9089.863652045224;9483.95676475587;9531.094546018117;9561.330706850593;9744.366616169926;331035;332282;338600;338808;340543;71326;72773;73121.63439182876;75026;78601;945.0691069296737;964.8359778837614;972.2027937091517;979.1236843025453;984.6455276100598;15449;15718.449854255046;15765.763513547536;15849.445269415515;16198.271077801763;35126.47310290399;36465;36491.63508364988;36510.08724781795;37945.81027094957;50336.244956324954;51171.74414127906;51695.70760731012;52596;52852.207216892544;7021.297870212938;7248.492605517774;7261.709531618676;7697.461177717506;7703.383729301754;10748.301360411548;10994;11730.12024098213;12035.744205528916;12209.145359824726;10029.247806414402;10098.545565449425;10176;10379.64196773028;10518.737031574272;8772.771811946204;9895.703128906145;10203.591856325664;10331.586736530455;10476.895231047896;10129.936356682441;10170.745731356776;10193.286469947032;10327.225458090523;10717.678469645924;7514.511556748794;7543.396528277615;7678.424118191269;7688.231176882267;7743.690252390066;9206.723798286062;10342.586296548054;10382.48087595602;10387;10524.105451036748 07:18:03 INFO - PROCESS | 21176 | |3;mootools.html;1252.8496580410351;1423.409285146664;1441.8053562769026;1558.2676142213163;1702.6169111949812;6367.617942923422;7479.177290498048;7648.655810488527;7657.846843063136;7671.884921726171;7483.550986940787;7632.580208088553;7634.809129771745;7636.129148358646;7658.234176582339;1902.838258748008;1966.9704954425624;2159.287435146398;2210.126999835064;2248.201888329644;2096.3710886733993;2131.019730923777;2135.6049130910833;2137.732783402075;2139.048123585005;2067.824234940032;2107.6311645461983;2138.219549864296;2139.0267428320076;2140.818030467412;1853.462495876201;2049.9795002050087;2103.053625868358;2115.428834214769;2118.682197670362;2156.439325775294;2161.827053835689;2181.5527816797517;2185.3225500095023;2189.981658528776;7538.396928245727;7560.810979725496;7587.051618547682;7619.961900190519;7621.733239336597;4435;4586.72479651222;4592.058627981256;4597.264437689953;4602.539746025404;2904.5788360687584;2909.156344660046;2909.2726818295428;2942.617459730243;2977.330100727319;859.4370687199894;873.5021038008338;887.2502735188755;894.3069121430879;899.3120262998812;10498.580056797718;10559.155267578575;10590.682279531626;10599.62901298451;10613.150947924147;4100.466939297872;4168.24971505132;4246.808893599734;4256.3828244904935;4270.530241673413;8914;8964.68623598171;8968.23769979546;8986.415882967585;8989.190972812477;4658.021815418732;4661.067786442725;4672.112298663311;4675.251959686434;4677;3757.361248587692;4168.854090106832;4245.830166793294;4264.701470897007;4270.487541494978;3598.208394153282;3602.513660655778;3695.7597756145765;3717.5167228260693;3761.2665530221343;1181.6691326428613;1194.3610168559778;1196.9820452693216;1203.1577895473204;1211.8606360268507;618.2889676871633;788.9013873265842;808.4987307869042;814.259024287907;821.3880658909151;4670.972386075058;4830.7101573905675;4905.460399356068;4926.261060840902;4941.604671626261;399.99200015999514;411.5205785260138;416.2902251660911;420.91160856219926;421.8186179942654;3265.934681306408;3319.286353434023;3319.8672053117607;3341.4486609709124;3345.916352091217;8819.382643214913;9064.501452420049;9264.7683807904;9596.95201523988;9622.230221582256;9131.223845973167;9214.631414743335;9292.628294868266;9298.163165315154;9305.906940930505;6931.861362772817;7027.086478757728;7150.213476517579;7194.784156475314;7251.7099316027825;5109.386873575195;5137.8201762938115;5215.608829337739;5269.341332333458;5299.205119232146;8171.264586187272;8328.3337333012;8456.492610443393;8733.257673097858;8749.781255468664;8740.169683880022;8817.735467935972;8848;8920;8967.955160224157;6038.9396106038375;6543.443807276435;6632.4694024478895;6775.627340496123;6787.490938179558;7345.192028876712;7437.702491900263;7500.324970752658;7502.174760776419;7508.549487030796;6593.769218077345;6637.236717777518;6698.66506674674;6717.596944183365;6929.68816403253;6467.126937863328;6518.250401203923;6699.330066993261;6791.966040169767;6853.7943861684225;5831.387704291158;5895.14520394549;5904.0553511437965;5924.851878702894;5949;4200.579942005775;4262.87211383659;4353.107612939277;4500.054988452462;4511.939694171932;4199.454070970754;4206.453161089039;4268.850590229327;4274.8931276717085;4419.690621656453 07:18:03 INFO - PROCESS | 21176 | |4;prototype.html;300.1266315023281;307.37142543498544;314.9905502834914;318.04744789355885;318.23305832942606;4546.636269098472;4733.266343716721;4740.668153229271;4799.7360145192;4804.687695299807;4596.954030459694;4748.952510474895;4762.833300834472;4782.513093191538;4800.855974320767;3778.4710140580205;3792.2036372361836;3792.5448946126503;3815.5802861685193;3817.25563515114;3557.911052223702;3627.9455808162897;3752.4746535485056;3778.2254637799183;3798.54417469904;3732.4774531565604;3743.1577894973684;3759.6616304532586;3768.021788561;3770.3778876485485;3723.94414083789;3744.457053727208;3750.324941510527;3756.7370284080125;3757.380032294668;3362.4451965425674;3365.293288409437;3368.1579605098727;3383.2895092030703;3388.40702876998;4499.257622492285;4509.706869053533;4555.248384016633;4559.498455169929;4566.680332376735;4276.337167739005;4284.485861696617;4288.506821715511;4289.713086074165;4305.332673435622;4984.7319469641225;4985.700857948498;5005.74971251436;5011.173156429185;5022.673526220784;3376.5272861799367;3562.9643703562892;3565.3760591896576;3690.538682664667;3708.740388172829;5228.738563071831;5252.789888404459;5257.13257312543;5257.211418287249;5291.5448251730695;3668.2296717689583;3683.6132206117973;3685.760425572329;3707.2214834884435;3709.017110465729;3742.3825068863875;3751.043483911585;3757.0043938356357;3759.887203383903;3761.0785357587565;4040.6565441937178;4271;4274.722143060691;4286.442762440863;4287.335463003239;4937.7777999990085;4988.376452943382;5002.199648056294;5003.374578177728;5031.195008798648;1315.9342032898508;1352.1954437109903;1392.2829742682527;1393.5679939218874;1393.7560926837966;930.3952430919821;942.1144124522926;952.0717300631967;953.4470007395694;954.2175416158683;4683.437987441529;4688.156131896291;4708.176069187947;4713.717176969393;4744.651397558231;5445.128779395278;5459.945400546023;5503.11950087984;5506.146547285177;5506.394296627368;4300.505441874162;4678.719276843401;4680.3447517347595;4696.272077827942;4707.482176960531;2971.257185703574;2976.940461190764;2984.805987610798;2987.4174535965276;2994.9850250748605;5275.103232450492;5275.868103297372;5277.551408130352;5283.233931079972;5296.278709419454;5074.107758577649;5307.283516725192;5318.149096144675;5740.138979153077;5762.4525670061275;4870.659053866196;4911.631627627942;4919.827806026843;4943.332650092191;4947.505249475023;5184.403793563789;5190.8183213587345;5193.324867767166;5202.843914682566;5210.270562121382;4842.685225460334;5068.138416469135;5090.880006398735;5103.157978933583;5118.74406279692;4938.456769755396;4938.777755000961;4939.925901111558;4947.77735001933;4954.1825598775795;3629.49187113799;3651.7991510466118;3669.26614677071;3674.632536746304;3677.282929828658;4950.183219768698;5082.009008243357;5208.713520756395;5222.086134926297;5243.213517972335;4894.510548945077;5027.924581131359;5055.34280543527;5059.165237735732;5062.215356619729;4999.600031997505;5020.6234532410945;5030.673006254582;5035.244713293036;5042.672226305279;4837.153498137882;4955.851324460272;4957.909259962802;4964.975175124246;4975.706316357845;5055.823046193365;5056.6713163644245;5071.695698257969;5075.746212689424;5092.363454568179;4912.1158191525865;4950.851474455772;4974.676646017997;4981.726005069756;4984.37695288089 07:18:03 INFO - PROCESS | 21176 | |5;yui.html;645.4062262718298;665.517499812636;715.5420530860249;757.0536828963795;762.8703120469521;11668.708282292937;12097.09271804615;13623.863761362396;14061.296935153227;14136.929315353435;13145.277009764459;13152.473901043946;13171.6707082323;13243.205407675523;13273.40269687864;639.4053530216896;777.6034222546485;807.261355859388;807.9757607271762;815.5066184958104;812.0823469479479;813.9674413023472;815.388458656008;816.824382757707;817.3012074676155;850.6937502499095;851.0723311590365;852.2074470742207;852.6631980367752;852.9019162796296;656.9441597464221;819.7581713394503;846.8475674378609;847.631280393031;853.0573716043775;615.938406159385;616.1374076293181;616.46675625584;616.5037145098194;616.516034912596;12701.809472857914;12766.744665106738;12769.425375858109;12772.233665979978;12790.104692671517;11816.586419475363;12033.217840840318;12219.69450763738;12380.690482737913;12523.123381363308;9597.184239339595;9753.989229576942;9797.118259356621;9853.162481189107;10004.39973601579;3242.20565961341;3288.7369010479106;3299.2741596848655;3352.228987332927;3375.5949286085583;42371.57628423707;42879.785601071795;42955.7852210737;43007.35488967668;43053.784731076456;9274.165325120772;9426.575804088832;9567.043295670377;10024.097831195082;10055.899441005497;16719.414820481226;16845.494635160965;17163.056031918113;17184.054876981885;17190.1404929753;6395.42441180296;6402.679866006681;6617.8014659560295;6623.4701223901975;6857.485688573377;3501.089716673683;3516.0682419158943;3533.3286675531567;3536.6109727929907;3630.7640003400224;2677.5715885458235;2758.9724102758714;2759.310172456886;2765.6681198255937;2767.9031233906717;495.57628227864654;520.4873199898173;524.8425472358354;549.686678593198;576.2738948924385;551.9862003449946;569.9515541178963;586.3608666553392;605.6335916770379;633.0838315937556;7623.313901748869;7811.773644511401;7882.605869706492;7941.404394670423;8123.512589244664;593.217381767785;612.4182027074297;615.7290792051483;619.1764952613014;621.1056079245872;3716.939248847748;3863.5750067492554;3864.9227015459533;3875.593062728373;3900.473436086092;53624.731876341146;54269.1859622106;54957;55111.44888551063;55142.72428637831;48649;48955.26567101496;49081.509184908406;49398.25902611392;50426;44905.77547112243;45173.77413112913;45217.32174017327;45936.5406345939;46155.5384446158;7036.9296307036275;7118.25258347866;7419.888701669587;7441.069866266716;7497.175310715926;28998.855005724836;29420.852895735385;29508;30281.545776812924;30502.237444064074;37080.81459592685;37285;38130.42804357882;39602.207955840146;41514;9348.485833279236;9359.298052645943;9362.110599493037;9369.578368973276;9715;9853.261005424478;10358.689239322832;10389.168866490814;10575.15398768112;10811.405372704578;9003.054679258583;9076.09239076087;9083;9199.86200206984;9761.414315141114;9733.854642162494;9775.608975640895;9783.80432391334;9908.603655853973;10436.16510679159;9558.091981261769;9562.569684364082;9742.366746161477;9855.162311203629;10140.594376224868;8037.276645101969;8060.919390806017;8152.551609661526;8316;8337.916620833957;7953.5227886327;8125;8248.711295104882;8461.06928237881;8509.276711479593 07:18:03 INFO - PROCESS | 21176 | __end_tp_report 07:18:03 INFO - PROCESS | 21176 | __start_cc_report 07:18:03 INFO - PROCESS | 21176 | _x_x_mozilla_cycle_collect,897 07:18:03 INFO - PROCESS | 21176 | __end_cc_report 07:18:03 INFO - PROCESS | 21176 | __startTimestamp1461593883568__endTimestamp 07:18:03 INFO - PROCESS | 21176 | 07:18:03 INFO - PROCESS | 21176 | ------- Summary: start ------- 07:18:03 INFO - PROCESS | 21176 | Number of tests: 6 07:18:03 INFO - PROCESS | 21176 | 07:18:03 INFO - PROCESS | 21176 | [#0] dojo.html Cycles:165 Average:4689.76 Median:4818.95 stddev:481.64 (10.0%) stddev-sans-first:455.51 07:18:03 INFO - PROCESS | 21176 | Values: 2640.8 2706.9 2708.4 2716.9 2736.3 4656.1 4669.3 4708.1 4714.7 4755.0 4699.2 4761.2 4768.4 4819.7 4852.6 4316.9 4320.4 4358.1 4380.8 4469.8 4405.1 4421.7 4432.6 4476.9 4481.0 4286.0 4336.6 4372.3 4378.6 4414.7 4309.1 4344.6 4349.9 4359.2 4406.4 4343.1 4378.3 4386.3 4397.4 4422.2 4426.1 4465.1 4598.3 4614.2 4697.2 5072.9 5079.5 5085.9 5086.5 5113.4 5100.9 5111.1 5118.5 5122.2 5131.7 4646.2 4705.6 4742.4 4796.7 4804.7 5178.9 5192.9 5194.0 5201.8 5204.2 4968.4 4979.3 4981.9 4994.8 5025.1 4915.0 5031.6 5093.8 5135.2 5142.8 4996.6 5029.2 5030.3 5039.1 5088.7 4833.6 5000.2 5001.1 5011.1 5018.5 4200.6 4219.9 4289.3 4297.1 4299.2 3729.0 3738.0 3745.1 3765.1 3773.1 4411.0 4417.5 4425.2 4460.9 4463.3 5000.3 5036.4 5082.5 5113.5 5157.3 4425.2 4435.7 4452.2 4455.9 4463.4 4584.9 4586.2 4587.1 4592.3 4634.4 4631.5 4777.4 4811.2 4819.0 4854.0 5094.4 5103.4 5109.6 5112.2 5138.8 4801.3 4803.3 4806.4 4812.8 4841.1 4869.7 4942.6 4943.2 5003.8 5061.0 5064.3 5086.4 5110.3 5114.7 5119.1 4921.6 4925.3 4927.5 4931.3 4972.0 4922.3 4922.6 4929.1 4931.4 4989.6 4742.6 4856.1 4922.2 4966.3 4972.5 4934.7 4954.1 4956.8 4959.0 5015.0 4754.1 4834.3 4837.2 4865.4 4924.4 07:18:03 INFO - PROCESS | 21176 | 07:18:03 INFO - PROCESS | 21176 | [#1] ext.html Cycles:180 Average:42193.51 Median:34451.90 stddev:69493.50 (201.7%) stddev-sans-first:69618.23 07:18:03 INFO - PROCESS | 21176 | Values: 585.3 604.4 621.9 626.5 631.4 27154.6 34632.3 34816.3 34934.7 35280.3 36470.0 37138.3 37184.0 37248.0 37314.4 7198.3 7525.1 7736.7 7740.3 7751.4 9305.2 9596.0 9599.8 9610.2 9617.1 9652.3 9822.5 9835.6 9836.8 9837.9 9633.3 9701.0 9748.5 9751.5 9772.1 9553.4 9659.3 9663.5 9667.5 9931.7 36103.1 36638.5 36780.6 36782.6 36856.3 2906.9 2918.8 2937.3 3183.2 3660.6 27939.6 28251.8 28311.7 28907.9 29343.4 3251.3 3254.0 3269.8 3293.2 3367.3 235904.0 237169.8 237451.0 237584.0 237846.0 49575.0 50040.0 50060.0 50174.0 50208.5 52616.0 52656.5 52672.7 52982.5 53030.2 13702.7 13960.7 13979.4 14113.1 14115.2 10695.8 10743.6 10749.4 10756.7 10761.9 15110.3 15526.8 15555.4 15582.3 15584.1 5579.6 5581.9 5742.4 5783.4 5783.6 792.4 833.2 873.6 892.7 960.5 26276.6 27851.2 28143.4 28234.0 28237.4 952.2 963.6 966.9 1010.1 1059.0 14732.3 14861.2 14869.9 15227.0 15286.8 309673.0 311319.0 315652.0 315692.0 316048.0 48433.5 48479.0 48698.5 48761.0 48805.5 1002.9 1074.7 1199.7 1205.4 1264.1 25422.6 26783.9 28674.9 28730.6 28806.3 40368.0 40442.8 40831.4 40848.2 40868.6 233773.0 241477.0 243115.0 243321.0 243628.0 33744.2 34414.3 34449.5 34454.3 34502.5 35591.6 36418.8 36525.6 36793.4 37225.0 30806.8 30835.3 31666.4 32081.6 32540.2 33657.8 33763.5 33977.7 34104.7 34293.3 33924.8 34575.0 34598.0 34615.0 34918.0 30225.2 31367.8 31378.4 31542.7 31611.4 23970.9 24398.6 24430.6 24799.5 24880.3 07:18:03 INFO - PROCESS | 21176 | 07:18:03 INFO - PROCESS | 21176 | [#2] jquery.html Cycles:180 Average:22686.10 Median:4740.24 stddev:55827.37 (1177.7%) stddev-sans-first:55958.84 07:18:03 INFO - PROCESS | 21176 | Values: 373.5 381.1 381.7 388.6 400.8 15551.4 17109.6 17670.0 17969.2 18010.5 16605.1 16918.9 17214.8 17471.5 17479.7 5014.7 5134.2 5167.7 5174.9 5181.6 3645.1 5576.5 5870.0 5870.2 5902.8 5788.0 5810.9 5813.0 5844.7 5888.1 5765.7 5944.9 5962.8 5965.5 5973.2 3325.2 5019.2 5232.3 5265.4 5291.2 19851.9 20038.3 20581.2 20743.7 20791.5 1612.3 1738.3 1950.9 1978.2 2017.0 8801.7 9055.0 9116.6 9187.9 9452.6 1619.1 1662.3 1708.8 1768.9 1775.2 66502.7 67318.3 67328.0 67474.0 69342.7 9839.0 9850.7 9879.2 10017.1 10142.9 13769.0 13846.4 13879.8 13922.7 13947.9 6989.0 7045.5 7080.6 7156.5 7165.4 6402.0 6408.9 6420.5 6448.8 6614.5 4276.8 4380.2 4393.5 4447.6 4465.8 1687.9 1788.6 1792.7 1862.0 1863.3 763.6 811.8 848.7 894.5 968.9 16127.6 16482.6 16904.7 16991.4 17220.9 821.5 848.1 850.7 874.5 905.3 9089.9 9484.0 9531.1 9561.3 9744.4 331035.0 332282.0 338600.0 338808.0 340543.0 71326.0 72773.0 73121.6 75026.0 78601.0 945.1 964.8 972.2 979.1 984.6 15449.0 15718.4 15765.8 15849.4 16198.3 35126.5 36465.0 36491.6 36510.1 37945.8 50336.2 51171.7 51695.7 52596.0 52852.2 7021.3 7248.5 7261.7 7697.5 7703.4 10748.3 10994.0 11730.1 12035.7 12209.1 10029.2 10098.5 10176.0 10379.6 10518.7 8772.8 9895.7 10203.6 10331.6 10476.9 10129.9 10170.7 10193.3 10327.2 10717.7 7514.5 7543.4 7678.4 7688.2 7743.7 9206.7 10342.6 10382.5 10387.0 10524.1 07:18:03 INFO - PROCESS | 21176 | 07:18:03 INFO - PROCESS | 21176 | [#3] mootools.html Cycles:180 Average:4996.81 Median:4753.86 stddev:2823.10 (59.4%) stddev-sans-first:2816.99 07:18:03 INFO - PROCESS | 21176 | Values: 1252.8 1423.4 1441.8 1558.3 1702.6 6367.6 7479.2 7648.7 7657.8 7671.9 7483.6 7632.6 7634.8 7636.1 7658.2 1902.8 1967.0 2159.3 2210.1 2248.2 2096.4 2131.0 2135.6 2137.7 2139.0 2067.8 2107.6 2138.2 2139.0 2140.8 1853.5 2050.0 2103.1 2115.4 2118.7 2156.4 2161.8 2181.6 2185.3 2190.0 7538.4 7560.8 7587.1 7620.0 7621.7 4435.0 4586.7 4592.1 4597.3 4602.5 2904.6 2909.2 2909.3 2942.6 2977.3 859.4 873.5 887.3 894.3 899.3 10498.6 10559.2 10590.7 10599.6 10613.2 4100.5 4168.2 4246.8 4256.4 4270.5 8914.0 8964.7 8968.2 8986.4 8989.2 4658.0 4661.1 4672.1 4675.3 4677.0 3757.4 4168.9 4245.8 4264.7 4270.5 3598.2 3602.5 3695.8 3717.5 3761.3 1181.7 1194.4 1197.0 1203.2 1211.9 618.3 788.9 808.5 814.3 821.4 4671.0 4830.7 4905.5 4926.3 4941.6 400.0 411.5 416.3 420.9 421.8 3265.9 3319.3 3319.9 3341.4 3345.9 8819.4 9064.5 9264.8 9597.0 9622.2 9131.2 9214.6 9292.6 9298.2 9305.9 6931.9 7027.1 7150.2 7194.8 7251.7 5109.4 5137.8 5215.6 5269.3 5299.2 8171.3 8328.3 8456.5 8733.3 8749.8 8740.2 8817.7 8848.0 8920.0 8968.0 6038.9 6543.4 6632.5 6775.6 6787.5 7345.2 7437.7 7500.3 7502.2 7508.5 6593.8 6637.2 6698.7 6717.6 6929.7 6467.1 6518.3 6699.3 6792.0 6853.8 5831.4 5895.1 5904.1 5924.9 5949.0 4200.6 4262.9 4353.1 4500.1 4511.9 4199.5 4206.5 4268.9 4274.9 4419.7 07:18:03 INFO - PROCESS | 21176 | 07:18:03 INFO - PROCESS | 21176 | [#4] prototype.html Cycles:180 Average:4228.75 Median:4772.67 stddev:1213.69 (25.4%) stddev-sans-first:1180.74 07:18:03 INFO - PROCESS | 21176 | Values: 300.1 307.4 315.0 318.0 318.2 4546.6 4733.3 4740.7 4799.7 4804.7 4597.0 4749.0 4762.8 4782.5 4800.9 3778.5 3792.2 3792.5 3815.6 3817.3 3557.9 3627.9 3752.5 3778.2 3798.5 3732.5 3743.2 3759.7 3768.0 3770.4 3723.9 3744.5 3750.3 3756.7 3757.4 3362.4 3365.3 3368.2 3383.3 3388.4 4499.3 4509.7 4555.2 4559.5 4566.7 4276.3 4284.5 4288.5 4289.7 4305.3 4984.7 4985.7 5005.7 5011.2 5022.7 3376.5 3563.0 3565.4 3690.5 3708.7 5228.7 5252.8 5257.1 5257.2 5291.5 3668.2 3683.6 3685.8 3707.2 3709.0 3742.4 3751.0 3757.0 3759.9 3761.1 4040.7 4271.0 4274.7 4286.4 4287.3 4937.8 4988.4 5002.2 5003.4 5031.2 1315.9 1352.2 1392.3 1393.6 1393.8 930.4 942.1 952.1 953.4 954.2 4683.4 4688.2 4708.2 4713.7 4744.7 5445.1 5459.9 5503.1 5506.1 5506.4 4300.5 4678.7 4680.3 4696.3 4707.5 2971.3 2976.9 2984.8 2987.4 2995.0 5275.1 5275.9 5277.6 5283.2 5296.3 5074.1 5307.3 5318.1 5740.1 5762.5 4870.7 4911.6 4919.8 4943.3 4947.5 5184.4 5190.8 5193.3 5202.8 5210.3 4842.7 5068.1 5090.9 5103.2 5118.7 4938.5 4938.8 4939.9 4947.8 4954.2 3629.5 3651.8 3669.3 3674.6 3677.3 4950.2 5082.0 5208.7 5222.1 5243.2 4894.5 5027.9 5055.3 5059.2 5062.2 4999.6 5020.6 5030.7 5035.2 5042.7 4837.2 4955.9 4957.9 4965.0 4975.7 5055.8 5056.7 5071.7 5075.7 5092.4 4912.1 4950.9 4974.7 4981.7 4984.4 07:18:03 INFO - PROCESS | 21176 | 07:18:03 INFO - PROCESS | 21176 | [#5] yui.html Cycles:180 Average:12643.86 Median:581.32 stddev:14865.17 (2557.2%) stddev-sans-first:14879.57 07:18:03 INFO - PROCESS | 21176 | Values: 645.4 665.5 715.5 757.1 762.9 11668.7 12097.1 13623.9 14061.3 14136.9 13145.3 13152.5 13171.7 13243.2 13273.4 639.4 777.6 807.3 808.0 815.5 812.1 814.0 815.4 816.8 817.3 850.7 851.1 852.2 852.7 852.9 656.9 819.8 846.8 847.6 853.1 615.9 616.1 616.5 616.5 616.5 12701.8 12766.7 12769.4 12772.2 12790.1 11816.6 12033.2 12219.7 12380.7 12523.1 9597.2 9754.0 9797.1 9853.2 10004.4 3242.2 3288.7 3299.3 3352.2 3375.6 42371.6 42879.8 42955.8 43007.4 43053.8 9274.2 9426.6 9567.0 10024.1 10055.9 16719.4 16845.5 17163.1 17184.1 17190.1 6395.4 6402.7 6617.8 6623.5 6857.5 3501.1 3516.1 3533.3 3536.6 3630.8 2677.6 2759.0 2759.3 2765.7 2767.9 495.6 520.5 524.8 549.7 576.3 552.0 570.0 586.4 605.6 633.1 7623.3 7811.8 7882.6 7941.4 8123.5 593.2 612.4 615.7 619.2 621.1 3716.9 3863.6 3864.9 3875.6 3900.5 53624.7 54269.2 54957.0 55111.4 55142.7 48649.0 48955.3 49081.5 49398.3 50426.0 44905.8 45173.8 45217.3 45936.5 46155.5 7036.9 7118.3 7419.9 7441.1 7497.2 28998.9 29420.9 29508.0 30281.5 30502.2 37080.8 37285.0 38130.4 39602.2 41514.0 9348.5 9359.3 9362.1 9369.6 9715.0 9853.3 10358.7 10389.2 10575.2 10811.4 9003.1 9076.1 9083.0 9199.9 9761.4 9733.9 9775.6 9783.8 9908.6 10436.2 9558.1 9562.6 9742.4 9855.2 10140.6 8037.3 8060.9 8152.6 8316.0 8337.9 7953.5 8125.0 8248.7 8461.1 8509.3 07:18:03 INFO - PROCESS | 21176 | -------- Summary: end -------- 07:18:03 INFO - PROCESS | 21176 | 07:18:04 INFO - TEST-INFO | 21176: exit 0 07:18:04 INFO - TEST-OK | dromaeo_css | took 1118509ms 07:18:04 INFO - TEST-START | kraken 07:18:04 INFO - operating with platform_type : linux_ 07:18:04 INFO - Initialising browser for kraken test... 07:18:04 INFO - TEST-INFO | started process 21359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGxUsxY/profile http://localhost:41142/getInfo.html) 07:18:08 INFO - PROCESS | 21359 | __metrics Screen width/height:1600/1200 07:18:08 INFO - PROCESS | 21359 | colorDepth:24 07:18:08 INFO - PROCESS | 21359 | Browser inner width/height: 1024/697 07:18:08 INFO - PROCESS | 21359 | __metrics 07:18:09 ERROR - PROCESS | 21359 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:18:10 INFO - TEST-INFO | 21359: exit 0 07:18:10 INFO - Browser initialized. 07:18:10 INFO - Running cycle 1/1 for kraken test... 07:18:10 INFO - TEST-INFO | started process 21441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGxUsxY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:18:22 INFO - PROCESS | 21441 | RSS: Main: 156217344 07:18:22 INFO - PROCESS | 21441 | 07:18:25 INFO - PROCESS | 21441 | Cycle 1(1): loaded http://localhost:41142/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41142/tests/kraken/driver.html?testName=audio-beat-detection) 07:18:26 INFO - PROCESS | 21441 | RSS: Main: 210493440 07:18:26 INFO - PROCESS | 21441 | 07:18:28 INFO - PROCESS | 21441 | Cycle 1(1): loaded http://localhost:41142/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41142/tests/kraken/driver.html?testName=audio-dft) 07:18:29 INFO - PROCESS | 21441 | RSS: Main: 197033984 07:18:29 INFO - PROCESS | 21441 | 07:18:32 INFO - PROCESS | 21441 | Cycle 1(1): loaded http://localhost:41142/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41142/tests/kraken/driver.html?testName=audio-fft) 07:18:33 INFO - PROCESS | 21441 | RSS: Main: 267350016 07:18:33 INFO - PROCESS | 21441 | 07:18:35 INFO - PROCESS | 21441 | Cycle 1(1): loaded http://localhost:41142/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41142/tests/kraken/driver.html?testName=audio-oscillator) 07:18:36 INFO - PROCESS | 21441 | RSS: Main: 175968256 07:18:36 INFO - PROCESS | 21441 | 07:18:38 INFO - PROCESS | 21441 | Cycle 1(1): loaded http://localhost:41142/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41142/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:18:38 INFO - PROCESS | 21441 | RSS: Main: 179482624 07:18:38 INFO - PROCESS | 21441 | 07:18:42 INFO - PROCESS | 21441 | Cycle 1(1): loaded http://localhost:41142/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41142/tests/kraken/driver.html?testName=imaging-darkroom) 07:18:42 INFO - PROCESS | 21441 | RSS: Main: 215539712 07:18:42 INFO - PROCESS | 21441 | 07:18:46 INFO - PROCESS | 21441 | Cycle 1(1): loaded http://localhost:41142/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41142/tests/kraken/driver.html?testName=imaging-desaturate) 07:18:46 INFO - PROCESS | 21441 | RSS: Main: 216686592 07:18:46 INFO - PROCESS | 21441 | 07:18:49 INFO - PROCESS | 21441 | Cycle 1(1): loaded http://localhost:41142/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41142/tests/kraken/driver.html?testName=json-parse-financial) 07:18:50 INFO - PROCESS | 21441 | RSS: Main: 217161728 07:18:50 INFO - PROCESS | 21441 | 07:18:51 INFO - PROCESS | 21441 | Cycle 1(1): loaded http://localhost:41142/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41142/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:18:52 INFO - PROCESS | 21441 | RSS: Main: 201916416 07:18:52 INFO - PROCESS | 21441 | 07:18:54 INFO - PROCESS | 21441 | Cycle 1(1): loaded http://localhost:41142/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41142/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:18:55 INFO - PROCESS | 21441 | RSS: Main: 204832768 07:18:55 INFO - PROCESS | 21441 | 07:18:57 INFO - PROCESS | 21441 | Cycle 1(1): loaded http://localhost:41142/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41142/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:18:57 INFO - PROCESS | 21441 | RSS: Main: 216924160 07:18:57 INFO - PROCESS | 21441 | 07:19:00 INFO - PROCESS | 21441 | Cycle 1(1): loaded http://localhost:41142/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:19:01 INFO - PROCESS | 21441 | RSS: Main: 224534528 07:19:01 INFO - PROCESS | 21441 | 07:19:04 INFO - PROCESS | 21441 | Cycle 1(1): loaded http://localhost:41142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:19:04 INFO - PROCESS | 21441 | RSS: Main: 221601792 07:19:04 INFO - PROCESS | 21441 | 07:19:06 INFO - PROCESS | 21441 | Cycle 1(1): loaded http://localhost:41142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41142/tests/kraken/driver.html?testName=ai-astar) 07:19:06 INFO - PROCESS | 21441 | RSS: Main: 285003776 07:19:06 INFO - PROCESS | 21441 | 07:19:06 INFO - PROCESS | 21441 | __start_tp_report 07:19:06 INFO - PROCESS | 21441 | _x_x_mozilla_page_load 07:19:06 INFO - PROCESS | 21441 | _x_x_mozilla_page_load_details 07:19:06 INFO - PROCESS | 21441 | |i|pagename|runs| 07:19:06 INFO - PROCESS | 21441 | |0;ai-astar;112;116;109;112;115;115;102;114;112;115 07:19:06 INFO - PROCESS | 21441 | |1;audio-beat-detection;162;133;164;205;140;170;163;137;186;132 07:19:06 INFO - PROCESS | 21441 | |2;audio-dft;161;160;160;162;161;162;161;160;160;159 07:19:06 INFO - PROCESS | 21441 | |3;audio-fft;78;74;114;113;74;74;73;120;103;78 07:19:06 INFO - PROCESS | 21441 | |4;audio-oscillator;95;96;155;95;95;93;141;93;95;142 07:19:06 INFO - PROCESS | 21441 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;118;118;117 07:19:06 INFO - PROCESS | 21441 | |6;imaging-darkroom;146;146;145;146;146;147;145;146;146;146 07:19:06 INFO - PROCESS | 21441 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;94;95 07:19:06 INFO - PROCESS | 21441 | |8;json-parse-financial;66;66;66;66;64;66;67;81;64;64 07:19:06 INFO - PROCESS | 21441 | |9;json-stringify-tinderbox;64;65;65;64;65;65;65;65;70;64 07:19:06 INFO - PROCESS | 21441 | |10;stanford-crypto-aes;78;78;79;78;80;78;87;78;80;80 07:19:06 INFO - PROCESS | 21441 | |11;stanford-crypto-ccm;137;132;133;134;130;134;134;136;161;129 07:19:06 INFO - PROCESS | 21441 | |12;stanford-crypto-pbkdf2;172;173;177;179;174;176;174;173;170;173 07:19:06 INFO - PROCESS | 21441 | |13;stanford-crypto-sha256-iterative;73;73;76;72;73;72;72;71;72;71 07:19:06 INFO - PROCESS | 21441 | __end_tp_report 07:19:06 INFO - PROCESS | 21441 | __start_cc_report 07:19:06 INFO - PROCESS | 21441 | _x_x_mozilla_cycle_collect,1893 07:19:06 INFO - PROCESS | 21441 | __end_cc_report 07:19:06 INFO - PROCESS | 21441 | __startTimestamp1461593946756__endTimestamp 07:19:06 INFO - PROCESS | 21441 | 07:19:06 INFO - PROCESS | 21441 | ------- Summary: start ------- 07:19:06 INFO - PROCESS | 21441 | Number of tests: 14 07:19:06 INFO - PROCESS | 21441 | 07:19:06 INFO - PROCESS | 21441 | [#0] ai-astar Cycles:10 Average:112.20 Median:114.50 stddev:4.16 (3.6%) stddev-sans-first:4.41 07:19:06 INFO - PROCESS | 21441 | Values: 112.0 116.0 109.0 112.0 115.0 115.0 102.0 114.0 112.0 115.0 07:19:06 INFO - PROCESS | 21441 | 07:19:06 INFO - PROCESS | 21441 | [#1] audio-beat-detection Cycles:10 Average:159.20 Median:163.50 stddev:24.19 (14.8%) stddev-sans-first:25.63 07:19:06 INFO - PROCESS | 21441 | Values: 162.0 133.0 164.0 205.0 140.0 170.0 163.0 137.0 186.0 132.0 07:19:06 INFO - PROCESS | 21441 | 07:19:06 INFO - PROCESS | 21441 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 07:19:06 INFO - PROCESS | 21441 | Values: 161.0 160.0 160.0 162.0 161.0 162.0 161.0 160.0 160.0 159.0 07:19:06 INFO - PROCESS | 21441 | 07:19:06 INFO - PROCESS | 21441 | [#3] audio-fft Cycles:10 Average:90.10 Median:74.00 stddev:19.77 (26.7%) stddev-sans-first:20.48 07:19:06 INFO - PROCESS | 21441 | Values: 78.0 74.0 114.0 113.0 74.0 74.0 73.0 120.0 103.0 78.0 07:19:06 INFO - PROCESS | 21441 | 07:19:06 INFO - PROCESS | 21441 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:95.00 stddev:25.13 (26.5%) stddev-sans-first:26.06 07:19:06 INFO - PROCESS | 21441 | Values: 95.0 96.0 155.0 95.0 95.0 93.0 141.0 93.0 95.0 142.0 07:19:06 INFO - PROCESS | 21441 | 07:19:06 INFO - PROCESS | 21441 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:19:06 INFO - PROCESS | 21441 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 118.0 118.0 117.0 07:19:06 INFO - PROCESS | 21441 | 07:19:06 INFO - PROCESS | 21441 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 07:19:06 INFO - PROCESS | 21441 | Values: 146.0 146.0 145.0 146.0 146.0 147.0 145.0 146.0 146.0 146.0 07:19:06 INFO - PROCESS | 21441 | 07:19:06 INFO - PROCESS | 21441 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:19:06 INFO - PROCESS | 21441 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 07:19:06 INFO - PROCESS | 21441 | 07:19:06 INFO - PROCESS | 21441 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:66.00 stddev:5.03 (7.6%) stddev-sans-first:5.33 07:19:06 INFO - PROCESS | 21441 | Values: 66.0 66.0 66.0 66.0 64.0 66.0 67.0 81.0 64.0 64.0 07:19:06 INFO - PROCESS | 21441 | 07:19:06 INFO - PROCESS | 21441 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:1.75 (2.7%) stddev-sans-first:1.80 07:19:06 INFO - PROCESS | 21441 | Values: 64.0 65.0 65.0 64.0 65.0 65.0 65.0 65.0 70.0 64.0 07:19:06 INFO - PROCESS | 21441 | 07:19:06 INFO - PROCESS | 21441 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.50 stddev:2.76 (3.5%) stddev-sans-first:2.86 07:19:06 INFO - PROCESS | 21441 | Values: 78.0 78.0 79.0 78.0 80.0 78.0 87.0 78.0 80.0 80.0 07:19:06 INFO - PROCESS | 21441 | 07:19:06 INFO - PROCESS | 21441 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:134.00 stddev:9.12 (6.8%) stddev-sans-first:9.66 07:19:06 INFO - PROCESS | 21441 | Values: 137.0 132.0 133.0 134.0 130.0 134.0 134.0 136.0 161.0 129.0 07:19:06 INFO - PROCESS | 21441 | 07:19:06 INFO - PROCESS | 21441 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:174.00 stddev:2.60 (1.5%) stddev-sans-first:2.65 07:19:06 INFO - PROCESS | 21441 | Values: 172.0 173.0 177.0 179.0 174.0 176.0 174.0 173.0 170.0 173.0 07:19:06 INFO - PROCESS | 21441 | 07:19:06 INFO - PROCESS | 21441 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.50 stddev:1.43 (2.0%) stddev-sans-first:1.51 07:19:06 INFO - PROCESS | 21441 | Values: 73.0 73.0 76.0 72.0 73.0 72.0 72.0 71.0 72.0 71.0 07:19:06 INFO - PROCESS | 21441 | -------- Summary: end -------- 07:19:06 INFO - PROCESS | 21441 | 07:19:07 INFO - TEST-INFO | 21441: exit 0 07:19:07 INFO - TEST-OK | kraken | took 63419ms 07:19:07 INFO - SUITE-END | took 1181s 07:19:07 INFO - Completed test suite (00:19:42) 07:19:07 INFO - javascript benchmark 07:19:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2640.84154950703, 2706.936462324394, 2708.377073273148, 2716.945661086777, 2736.329599248184, 4656.138614356347, 4669.299605059243, 4708.0819240248165, 4714.740689262094, 4755.048990201956, 4699.248120300753, 4761.238201887699, 4768.356271903292, 4819.662623616348, 4852.58753005994, 4316.913661726763, 4320.416743739602, 4358.0848021915435, 4380.846670366538, 4469.776511174445, 4405.096955124208, 4421.668374871898, 4432.645388368939, 4476.932846007313, 4480.955190448087, 4285.957140428587, 4336.56634336567, 4372.300431930876, 4378.605925466692, 4414.690971631987, 4309.1381723655395, 4344.587264209895, 4349.934750978738, 4359.193549193409, 4406.4271644686305, 4343.109662519208, 4378.343248512749, 4386.34204869269, 4397.428334316518, 4422.248217802981, 4426.136903303857, 4465.062336909253, 4598.2642777155825, 4614.238650622643, 4697.177993851063, 5072.898542029138, 5079.466656001104, 5085.872853178663, 5086.54221120101, 5113.437521872591, 5100.9489905100845, 5111.105556527593, 5118.539331460186, 5122.231665250205, 5131.666441681279, 4646.210144275515, 4705.55297246761, 4742.359781429497, 4796.736179510161, 4804.663673542888, 5178.922316165261, 5192.870178245574, 5194.039102766001, 5201.817936372209, 5204.245384419238, 4968.403791545038, 4979.3277907482025, 4981.875453113701, 4994.750262486861, 5025.070361983045, 4915.0415668944215, 5031.572316353151, 5093.821716239914, 5135.229715542699, 5142.794288228504, 4996.625253105959, 5029.245613158056, 5030.320906677625, 5039.143345631252, 5088.72012039334, 4833.564979151823, 5000.2499625056535, 5001.099802035668, 5011.1481048221885, 5018.5232402921665, 4200.558941311179, 4219.915601687949, 4289.270823959934, 4297.05464797744, 4299.204647140289, 3728.993171843587, 3738.0467980664757, 3745.138618117848, 3765.1340191755503, 3773.094457330276, 4410.963423595453, 4417.514073451917, 4425.22558552252, 4460.929376949509, 4463.330500424962, 5000.349954505891, 5036.420811606639, 5082.466341034138, 5113.539781419616, 5157.303763991888, 4425.247707889666, 4435.667324950641, 4452.220861349316, 4455.888602784957, 4463.419755431838, 4584.862454126382, 4586.197415452282, 4587.128445595326, 4592.334111553872, 4634.351190833286, 4631.467381251199, 4777.402824646919, 4811.230203167476, 4818.951810481921, 4854.0, 5094.388673359221, 5103.413107492686, 5109.642325037212, 5112.182050871843, 5138.845834624967, 4801.279808028684, 4803.327534145153, 4806.399200099988, 4812.831550895702, 4841.080194762983, 4869.732164730974, 4942.57988071018, 4943.159662857395, 5003.77483013258, 5061.038402703622, 5064.290999260033, 5086.440491546001, 5110.310108135503, 5114.667546609458, 5119.104156772624, 4921.557059864629, 4925.310456536016, 4927.507249275044, 4931.3096166536, 4972.0, 4922.335484709519, 4922.581580565548, 4929.063477939323, 4931.3835770528685, 4989.625778066587, 4742.596879265301, 4856.053069651384, 4922.187839006524, 4966.279889416087, 4972.477889821661, 4934.654574179773, 4954.133026720381, 4956.752162391938, 4958.950410495993, 5014.974925125351, 4754.120487709784, 4834.299026641047, 4837.153498137882, 4865.391826021747, 4924.359833221658], "value": 4659.867368018852, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.259646547118, 604.4167378479766, 621.9253689557254, 626.5301024231825, 631.3844002097952, 27154.592681109774, 34632.307353852906, 34816.30367392651, 34934.65065349346, 35280.294394112105, 36470.0, 37138.257234855286, 37184.0, 37248.0, 37314.44028339571, 7198.280171982786, 7525.096988361404, 7736.729214477495, 7740.303372696456, 7751.418643601724, 9305.209057230144, 9595.952020239924, 9599.760005999837, 9610.231181505464, 9617.086376794194, 9652.324337296392, 9822.508874556244, 9835.557399917021, 9836.803263934717, 9837.852432213522, 9633.27750418718, 9700.951495242478, 9748.512574371252, 9751.463669498175, 9772.071653192936, 9553.379030363074, 9659.275554333453, 9663.516824158763, 9667.468289244089, 9931.652392166312, 36103.09742256438, 36638.450423243674, 36780.632193677986, 36782.63217367819, 36856.26287474262, 2906.89825856094, 2918.751906087985, 2937.3390987027747, 3183.2360233544014, 3660.6156353583024, 27939.58090628642, 28251.82231947911, 28311.716882831115, 28907.855460722563, 29343.413131737245, 3251.252211991255, 3253.995171877185, 3269.820159891205, 3293.2096296888813, 3367.3433680432327, 235904.0, 237169.81415092986, 237451.0, 237584.0, 237846.0, 49575.0, 50040.0, 50060.0, 50174.0, 50208.49791502038, 52616.0, 52656.47343526516, 52672.73663631657, 52982.470175297756, 53030.204546931825, 13702.65743356424, 13960.650983725489, 13979.440822367194, 14113.08264962774, 14115.153090814583, 10695.83956240657, 10743.570257189625, 10749.355038697704, 10756.731081722863, 10761.946190268998, 15110.320035598425, 15526.844731552766, 15555.377784888478, 15582.298796554182, 15584.14567766841, 5579.609427340129, 5581.920452388307, 5742.425757424307, 5783.392743761844, 5783.583022159513, 792.4096548071608, 833.2417500074903, 873.5501216873315, 892.723255790694, 960.5053397500293, 26276.605850912252, 27851.164465066082, 28143.43713125767, 28234.0, 28237.43525129486, 952.1620973543238, 963.5952899782109, 966.8936416994125, 1010.0656892374524, 1058.9841152382721, 14732.312239151586, 14861.182634954965, 14869.851301486846, 15227.0, 15286.770698439532, 309673.0, 311319.0, 315652.0, 315692.0, 316048.0, 48433.5156648436, 48479.0, 48698.5130148694, 48761.0, 48805.511944880804, 1002.904724051214, 1074.6990842564094, 1199.7120691034088, 1205.39127740494, 1264.121435602266, 25422.618660720473, 26783.86608066947, 28674.856625717573, 28730.569041464812, 28806.279843004093, 40368.0, 40442.79778601088, 40831.38752918649, 40848.1830363397, 40868.59131408648, 233773.0, 241477.0, 243115.0, 243321.0, 243628.0, 33744.15639609029, 34414.31171376609, 34449.48325775166, 34454.31091378108, 34502.51467309234, 35591.64408355884, 36418.81790591136, 36525.63474365223, 36793.448098279085, 37225.0, 30806.845965770026, 30835.32267147809, 31666.366672665958, 32081.55632996474, 32540.186495337806, 33657.83171084129, 33763.48064337062, 33977.66022339745, 34104.65895341114, 34293.31413371669, 33924.83037584895, 34575.0, 34598.0, 34615.0, 34918.0, 30225.244368890955, 31367.843160784963, 31378.372432550765, 31542.684573154893, 31611.36777264396, 23970.88014559916, 24398.634020490063, 24430.63354049655, 24799.50400992006, 24880.25359239226], "value": 17156.01696396626, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.49391574416666, 381.11961369237065, 381.7041792610726, 388.6385661334959, 400.7535365750065, 15551.44352255317, 17109.57226069349, 17670.0, 17969.19138638761, 18010.5497362566, 16605.08672023038, 16918.915405422988, 17214.82785172148, 17471.475855724348, 17479.737803932952, 5014.72419016953, 5134.1528647773075, 5167.6641018333685, 5174.948250517503, 5181.6113791465605, 3645.052286405527, 5576.525995290405, 5870.0, 5870.20752198452, 5902.763889444439, 5787.971060144693, 5810.912836307459, 5813.01178799603, 5844.736986835582, 5888.116782482641, 5765.740541675614, 5944.910826337608, 5962.791302304442, 5965.4929331006915, 5973.163757073991, 3325.1687078230443, 5019.19692849146, 5232.2674825524455, 5265.420803711589, 5291.206319052135, 19851.908145052017, 20038.298659546846, 20581.176752929863, 20743.681011038312, 20791.480212994644, 1612.3308826836849, 1738.3133662203486, 1950.8634395592314, 1978.169168949045, 2016.9697454538193, 8801.735947921572, 9054.954725226398, 9116.58975346111, 9187.862182067207, 9452.621895124186, 1619.0771260381587, 1662.3184494357256, 1708.8034875989297, 1768.929242830298, 1775.1922875091932, 66502.66748666274, 67318.3268167317, 67328.0, 67474.0, 69342.65328673375, 9838.950805245928, 9850.704478865646, 9879.209663226924, 10017.14854237398, 10142.949285253526, 13769.0, 13846.376913038937, 13879.791803122962, 13922.721545569031, 13947.930260348836, 6988.965055174794, 7045.542039767399, 7080.575165490087, 7156.532910753387, 7165.390941769903, 6401.967990160019, 6408.935910640927, 6420.518461115342, 6448.774292899726, 6614.470842332602, 4276.764777937244, 4380.233459144701, 4393.472783266028, 4447.62195213404, 4465.754383508938, 1687.9493615191564, 1788.5691446842734, 1792.7042038063835, 1862.01625790313, 1863.2826361850514, 763.6220071064747, 811.7970507373157, 848.7453763870814, 894.4677916639589, 968.9176420004237, 16127.596810079607, 16482.58793530171, 16904.661906761798, 16991.40530081441, 17220.913895430444, 821.4947807098711, 848.1137211613878, 850.6937502499095, 874.5321253129545, 905.2576886952767, 9089.863652045224, 9483.95676475587, 9531.094546018117, 9561.330706850593, 9744.366616169926, 331035.0, 332282.0, 338600.0, 338808.0, 340543.0, 71326.0, 72773.0, 73121.63439182876, 75026.0, 78601.0, 945.0691069296737, 964.8359778837614, 972.2027937091517, 979.1236843025453, 984.6455276100598, 15449.0, 15718.449854255046, 15765.763513547536, 15849.445269415515, 16198.271077801763, 35126.47310290399, 36465.0, 36491.63508364988, 36510.08724781795, 37945.81027094957, 50336.244956324954, 51171.74414127906, 51695.70760731012, 52596.0, 52852.207216892544, 7021.297870212938, 7248.492605517774, 7261.709531618676, 7697.461177717506, 7703.383729301754, 10748.301360411548, 10994.0, 11730.12024098213, 12035.744205528916, 12209.145359824726, 10029.247806414402, 10098.545565449425, 10176.0, 10379.64196773028, 10518.737031574272, 8772.771811946204, 9895.703128906145, 10203.591856325664, 10331.586736530455, 10476.895231047896, 10129.936356682441, 10170.745731356776, 10193.286469947032, 10327.225458090523, 10717.678469645924, 7514.511556748794, 7543.396528277615, 7678.424118191269, 7688.231176882267, 7743.690252390066, 9206.723798286062, 10342.586296548054, 10382.48087595602, 10387.0, 10524.105451036748], "value": 8143.5260416115725, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1252.8496580410351, 1423.409285146664, 1441.8053562769026, 1558.2676142213163, 1702.6169111949812, 6367.617942923422, 7479.177290498048, 7648.655810488527, 7657.846843063136, 7671.884921726171, 7483.550986940787, 7632.580208088553, 7634.809129771745, 7636.129148358646, 7658.234176582339, 1902.838258748008, 1966.9704954425624, 2159.287435146398, 2210.126999835064, 2248.201888329644, 2096.3710886733993, 2131.019730923777, 2135.6049130910833, 2137.732783402075, 2139.048123585005, 2067.824234940032, 2107.6311645461983, 2138.219549864296, 2139.0267428320076, 2140.818030467412, 1853.462495876201, 2049.9795002050087, 2103.053625868358, 2115.428834214769, 2118.682197670362, 2156.439325775294, 2161.827053835689, 2181.5527816797517, 2185.3225500095023, 2189.981658528776, 7538.396928245727, 7560.810979725496, 7587.051618547682, 7619.961900190519, 7621.733239336597, 4435.0, 4586.72479651222, 4592.058627981256, 4597.264437689953, 4602.539746025404, 2904.5788360687584, 2909.156344660046, 2909.2726818295428, 2942.617459730243, 2977.330100727319, 859.4370687199894, 873.5021038008338, 887.2502735188755, 894.3069121430879, 899.3120262998812, 10498.580056797718, 10559.155267578575, 10590.682279531626, 10599.62901298451, 10613.150947924147, 4100.466939297872, 4168.24971505132, 4246.808893599734, 4256.3828244904935, 4270.530241673413, 8914.0, 8964.68623598171, 8968.23769979546, 8986.415882967585, 8989.190972812477, 4658.021815418732, 4661.067786442725, 4672.112298663311, 4675.251959686434, 4677.0, 3757.361248587692, 4168.854090106832, 4245.830166793294, 4264.701470897007, 4270.487541494978, 3598.208394153282, 3602.513660655778, 3695.7597756145765, 3717.5167228260693, 3761.2665530221343, 1181.6691326428613, 1194.3610168559778, 1196.9820452693216, 1203.1577895473204, 1211.8606360268507, 618.2889676871633, 788.9013873265842, 808.4987307869042, 814.259024287907, 821.3880658909151, 4670.972386075058, 4830.7101573905675, 4905.460399356068, 4926.261060840902, 4941.604671626261, 399.99200015999514, 411.5205785260138, 416.2902251660911, 420.91160856219926, 421.8186179942654, 3265.934681306408, 3319.286353434023, 3319.8672053117607, 3341.4486609709124, 3345.916352091217, 8819.382643214913, 9064.501452420049, 9264.7683807904, 9596.95201523988, 9622.230221582256, 9131.223845973167, 9214.631414743335, 9292.628294868266, 9298.163165315154, 9305.906940930505, 6931.861362772817, 7027.086478757728, 7150.213476517579, 7194.784156475314, 7251.7099316027825, 5109.386873575195, 5137.8201762938115, 5215.608829337739, 5269.341332333458, 5299.205119232146, 8171.264586187272, 8328.3337333012, 8456.492610443393, 8733.257673097858, 8749.781255468664, 8740.169683880022, 8817.735467935972, 8848.0, 8920.0, 8967.955160224157, 6038.9396106038375, 6543.443807276435, 6632.4694024478895, 6775.627340496123, 6787.490938179558, 7345.192028876712, 7437.702491900263, 7500.324970752658, 7502.174760776419, 7508.549487030796, 6593.769218077345, 6637.236717777518, 6698.66506674674, 6717.596944183365, 6929.68816403253, 6467.126937863328, 6518.250401203923, 6699.330066993261, 6791.966040169767, 6853.7943861684225, 5831.387704291158, 5895.14520394549, 5904.0553511437965, 5924.851878702894, 5949.0, 4200.579942005775, 4262.87211383659, 4353.107612939277, 4500.054988452462, 4511.939694171932, 4199.454070970754, 4206.453161089039, 4268.850590229327, 4274.8931276717085, 4419.690621656453], "value": 3954.992311901711, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.1266315023281, 307.37142543498544, 314.9905502834914, 318.04744789355885, 318.23305832942606, 4546.636269098472, 4733.266343716721, 4740.668153229271, 4799.7360145192, 4804.687695299807, 4596.954030459694, 4748.952510474895, 4762.833300834472, 4782.513093191538, 4800.855974320767, 3778.4710140580205, 3792.2036372361836, 3792.5448946126503, 3815.5802861685193, 3817.25563515114, 3557.911052223702, 3627.9455808162897, 3752.4746535485056, 3778.2254637799183, 3798.54417469904, 3732.4774531565604, 3743.1577894973684, 3759.6616304532586, 3768.021788561, 3770.3778876485485, 3723.94414083789, 3744.457053727208, 3750.324941510527, 3756.7370284080125, 3757.380032294668, 3362.4451965425674, 3365.293288409437, 3368.1579605098727, 3383.2895092030703, 3388.40702876998, 4499.257622492285, 4509.706869053533, 4555.248384016633, 4559.498455169929, 4566.680332376735, 4276.337167739005, 4284.485861696617, 4288.506821715511, 4289.713086074165, 4305.332673435622, 4984.7319469641225, 4985.700857948498, 5005.74971251436, 5011.173156429185, 5022.673526220784, 3376.5272861799367, 3562.9643703562892, 3565.3760591896576, 3690.538682664667, 3708.740388172829, 5228.738563071831, 5252.789888404459, 5257.13257312543, 5257.211418287249, 5291.5448251730695, 3668.2296717689583, 3683.6132206117973, 3685.760425572329, 3707.2214834884435, 3709.017110465729, 3742.3825068863875, 3751.043483911585, 3757.0043938356357, 3759.887203383903, 3761.0785357587565, 4040.6565441937178, 4271.0, 4274.722143060691, 4286.442762440863, 4287.335463003239, 4937.7777999990085, 4988.376452943382, 5002.199648056294, 5003.374578177728, 5031.195008798648, 1315.9342032898508, 1352.1954437109903, 1392.2829742682527, 1393.5679939218874, 1393.7560926837966, 930.3952430919821, 942.1144124522926, 952.0717300631967, 953.4470007395694, 954.2175416158683, 4683.437987441529, 4688.156131896291, 4708.176069187947, 4713.717176969393, 4744.651397558231, 5445.128779395278, 5459.945400546023, 5503.11950087984, 5506.146547285177, 5506.394296627368, 4300.505441874162, 4678.719276843401, 4680.3447517347595, 4696.272077827942, 4707.482176960531, 2971.257185703574, 2976.940461190764, 2984.805987610798, 2987.4174535965276, 2994.9850250748605, 5275.103232450492, 5275.868103297372, 5277.551408130352, 5283.233931079972, 5296.278709419454, 5074.107758577649, 5307.283516725192, 5318.149096144675, 5740.138979153077, 5762.4525670061275, 4870.659053866196, 4911.631627627942, 4919.827806026843, 4943.332650092191, 4947.505249475023, 5184.403793563789, 5190.8183213587345, 5193.324867767166, 5202.843914682566, 5210.270562121382, 4842.685225460334, 5068.138416469135, 5090.880006398735, 5103.157978933583, 5118.74406279692, 4938.456769755396, 4938.777755000961, 4939.925901111558, 4947.77735001933, 4954.1825598775795, 3629.49187113799, 3651.7991510466118, 3669.26614677071, 3674.632536746304, 3677.282929828658, 4950.183219768698, 5082.009008243357, 5208.713520756395, 5222.086134926297, 5243.213517972335, 4894.510548945077, 5027.924581131359, 5055.34280543527, 5059.165237735732, 5062.215356619729, 4999.600031997505, 5020.6234532410945, 5030.673006254582, 5035.244713293036, 5042.672226305279, 4837.153498137882, 4955.851324460272, 4957.909259962802, 4964.975175124246, 4975.706316357845, 5055.823046193365, 5056.6713163644245, 5071.695698257969, 5075.746212689424, 5092.363454568179, 4912.1158191525865, 4950.851474455772, 4974.676646017997, 4981.726005069756, 4984.37695288089], "value": 3854.8075470114118, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.4062262718298, 665.517499812636, 715.5420530860249, 757.0536828963795, 762.8703120469521, 11668.708282292937, 12097.09271804615, 13623.863761362396, 14061.296935153227, 14136.929315353435, 13145.277009764459, 13152.473901043946, 13171.6707082323, 13243.205407675523, 13273.40269687864, 639.4053530216896, 777.6034222546485, 807.261355859388, 807.9757607271762, 815.5066184958104, 812.0823469479479, 813.9674413023472, 815.388458656008, 816.824382757707, 817.3012074676155, 850.6937502499095, 851.0723311590365, 852.2074470742207, 852.6631980367752, 852.9019162796296, 656.9441597464221, 819.7581713394503, 846.8475674378609, 847.631280393031, 853.0573716043775, 615.938406159385, 616.1374076293181, 616.46675625584, 616.5037145098194, 616.516034912596, 12701.809472857914, 12766.744665106738, 12769.425375858109, 12772.233665979978, 12790.104692671517, 11816.586419475363, 12033.217840840318, 12219.69450763738, 12380.690482737913, 12523.123381363308, 9597.184239339595, 9753.989229576942, 9797.118259356621, 9853.162481189107, 10004.39973601579, 3242.20565961341, 3288.7369010479106, 3299.2741596848655, 3352.228987332927, 3375.5949286085583, 42371.57628423707, 42879.785601071795, 42955.7852210737, 43007.35488967668, 43053.784731076456, 9274.165325120772, 9426.575804088832, 9567.043295670377, 10024.097831195082, 10055.899441005497, 16719.414820481226, 16845.494635160965, 17163.056031918113, 17184.054876981885, 17190.1404929753, 6395.42441180296, 6402.679866006681, 6617.8014659560295, 6623.4701223901975, 6857.485688573377, 3501.089716673683, 3516.0682419158943, 3533.3286675531567, 3536.6109727929907, 3630.7640003400224, 2677.5715885458235, 2758.9724102758714, 2759.310172456886, 2765.6681198255937, 2767.9031233906717, 495.57628227864654, 520.4873199898173, 524.8425472358354, 549.686678593198, 576.2738948924385, 551.9862003449946, 569.9515541178963, 586.3608666553392, 605.6335916770379, 633.0838315937556, 7623.313901748869, 7811.773644511401, 7882.605869706492, 7941.404394670423, 8123.512589244664, 593.217381767785, 612.4182027074297, 615.7290792051483, 619.1764952613014, 621.1056079245872, 3716.939248847748, 3863.5750067492554, 3864.9227015459533, 3875.593062728373, 3900.473436086092, 53624.731876341146, 54269.1859622106, 54957.0, 55111.44888551063, 55142.72428637831, 48649.0, 48955.26567101496, 49081.509184908406, 49398.25902611392, 50426.0, 44905.77547112243, 45173.77413112913, 45217.32174017327, 45936.5406345939, 46155.5384446158, 7036.9296307036275, 7118.25258347866, 7419.888701669587, 7441.069866266716, 7497.175310715926, 28998.855005724836, 29420.852895735385, 29508.0, 30281.545776812924, 30502.237444064074, 37080.81459592685, 37285.0, 38130.42804357882, 39602.207955840146, 41514.0, 9348.485833279236, 9359.298052645943, 9362.110599493037, 9369.578368973276, 9715.0, 9853.261005424478, 10358.689239322832, 10389.168866490814, 10575.15398768112, 10811.405372704578, 9003.054679258583, 9076.09239076087, 9083.0, 9199.86200206984, 9761.414315141114, 9733.854642162494, 9775.608975640895, 9783.80432391334, 9908.603655853973, 10436.16510679159, 9558.091981261769, 9562.569684364082, 9742.366746161477, 9855.162311203629, 10140.594376224868, 8037.276645101969, 8060.919390806017, 8152.551609661526, 8316.0, 8337.916620833957, 7953.5227886327, 8125.0, 8248.711295104882, 8461.06928237881, 8509.276711479593], "value": 5778.860997852455, "unit": "score"}], "name": "dromaeo_css", "value": 6210.2225046454705, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 109.0, 112.0, 115.0, 115.0, 102.0, 114.0, 112.0, 115.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 133.0, 164.0, 205.0, 140.0, 170.0, 163.0, 137.0, 186.0, 132.0], "value": 159.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 162.0, 161.0, 162.0, 161.0, 160.0, 160.0, 159.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 114.0, 113.0, 74.0, 74.0, 73.0, 120.0, 103.0, 78.0], "value": 90.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 155.0, 95.0, 95.0, 93.0, 141.0, 93.0, 95.0, 142.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 64.0, 66.0, 67.0, 81.0, 64.0, 64.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 70.0, 64.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 78.0, 80.0, 78.0, 87.0, 78.0, 80.0, 80.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 133.0, 134.0, 130.0, 134.0, 134.0, 136.0, 161.0, 129.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 177.0, 179.0, 174.0, 176.0, 174.0, 173.0, 170.0, 173.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 76.0, 72.0, 73.0, 72.0, 72.0, 71.0, 72.0, 71.0], "value": 72.5, "unit": "score"}], "name": "kraken", "value": 1584.3, "alertThreshold": 2.0}]} 07:19:08 INFO - Return code: 0 07:19:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:19:08 ERROR - # TBPL SUCCESS # 07:19:08 INFO - Running post-action listener: _resource_record_post_action 07:19:08 INFO - Running post-run listener: _resource_record_post_run 07:19:09 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 528130048; Read time: 12; Write time: 574444 07:19:09 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 244461568; Read time: 0; Write time: 358960 07:19:09 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283553792; Read time: 12; Write time: 215484 07:19:09 INFO - Running post-run listener: _upload_blobber_files 07:19:09 INFO - Blob upload gear active. 07:19:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:19:09 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 07:19:09 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:19:09 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:19:09 INFO - (blobuploader) - INFO - Open directory for files ... 07:19:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:19:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:19:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:19:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:19:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:19:10 INFO - (blobuploader) - INFO - Done attempting. 07:19:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:19:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:19:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:19:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:19:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:19:11 INFO - (blobuploader) - INFO - Done attempting. 07:19:11 INFO - (blobuploader) - INFO - Iteration through files over. 07:19:11 INFO - Return code: 0 07:19:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:19:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:19:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e04606171f1478f32a28c0e01ebc8b6162e5d3e90529a1e5d8a2c030161ca3be994db4827bf33577bf07031accb990cd72fa60b3840129fe1f017ce0557ad2c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b18471f958faffb060206ec919ef61b874799a7d12d250b4ec77257b7a3c30d99fbc0ab33938f96b46d7caca92d84e97a0fba6925ac4efc292819ec78267383"} 07:19:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:19:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:19:11 INFO - Contents: 07:19:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e04606171f1478f32a28c0e01ebc8b6162e5d3e90529a1e5d8a2c030161ca3be994db4827bf33577bf07031accb990cd72fa60b3840129fe1f017ce0557ad2c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b18471f958faffb060206ec919ef61b874799a7d12d250b4ec77257b7a3c30d99fbc0ab33938f96b46d7caca92d84e97a0fba6925ac4efc292819ec78267383"} 07:19:11 INFO - Running post-run listener: copy_logs_to_upload_dir 07:19:11 INFO - Copying logs to upload dir... 07:19:11 INFO - mkdir: /builds/slave/test/build/upload/logs 07:19:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.609391 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-25 07:19:11.270023) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 07:19:11.275442) ========= 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=00204705a9daa57ed339a427000001b9-1461592625.283607-58725690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e04606171f1478f32a28c0e01ebc8b6162e5d3e90529a1e5d8a2c030161ca3be994db4827bf33577bf07031accb990cd72fa60b3840129fe1f017ce0557ad2c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b18471f958faffb060206ec919ef61b874799a7d12d250b4ec77257b7a3c30d99fbc0ab33938f96b46d7caca92d84e97a0fba6925ac4efc292819ec78267383"} build_url:https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/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/Fx-Team-Non-PGO/sha512/e04606171f1478f32a28c0e01ebc8b6162e5d3e90529a1e5d8a2c030161ca3be994db4827bf33577bf07031accb990cd72fa60b3840129fe1f017ce0557ad2c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0b18471f958faffb060206ec919ef61b874799a7d12d250b4ec77257b7a3c30d99fbc0ab33938f96b46d7caca92d84e97a0fba6925ac4efc292819ec78267383"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 07:19:11.300766) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:19:11.301151) ========= 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=00204705a9daa57ed339a427000001b9-1461592625.283607-58725690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:19:11.384266) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 07:19:11.384611) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 07:19:11.384987) ========= ========= Total master_lag: 0.18 =========