builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-042 starttime: 1475176974.09 results: success (0) buildid: 20160929100439 builduid: c742fcd76585495ba700dfddc77615dd revision: 1723fbc9d9d88a5fbf1c57cdd1e226e36f04c522 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 12:22:54.093296) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 12:22:54.093759) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 12:22:54.094050) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 12:22:54.108365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:22:54.108643) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-29 12:22:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-09-29 12:22:54 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101207 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:22:54.223359) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:22:54.223672) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020921 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:22:54.272820) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 12:22:54.273184) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1723fbc9d9d88a5fbf1c57cdd1e226e36f04c522 --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 1723fbc9d9d88a5fbf1c57cdd1e226e36f04c522 --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=74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-29 12:22:54,777 truncating revision to first 12 chars 2016-09-29 12:22:54,778 Setting DEBUG logging. 2016-09-29 12:22:54,778 attempt 1/10 2016-09-29 12:22:54,778 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1723fbc9d9d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 12:22:55,821 unpacking tar archive at: fx-team-1723fbc9d9d8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.380156 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 12:22:55.666720) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 12:22:55.667045) ========= script_repo_revision: 1723fbc9d9d88a5fbf1c57cdd1e226e36f04c522 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 12:22:55.667495) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 12:22:55.667768) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 12:22:55.677471) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-29 12:22:55.677862) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:22:56 INFO - MultiFileLogger online at 20160929 12:22:56 in /builds/slave/test 12:22:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 12:22:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:22:56 INFO - {'append_to_log': False, 12:22:56 INFO - 'base_work_dir': '/builds/slave/test', 12:22:56 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:22:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:22:56 INFO - 'branch': 'Fx-Team-Non-PGO', 12:22:56 INFO - 'buildbot_json_path': 'buildprops.json', 12:22:56 INFO - 'config_files': ('talos/linux_config.py',), 12:22:56 INFO - 'default_actions': ('clobber', 12:22:56 INFO - 'read-buildbot-config', 12:22:56 INFO - 'download-and-extract', 12:22:56 INFO - 'populate-webroot', 12:22:56 INFO - 'create-virtualenv', 12:22:56 INFO - 'install', 12:22:56 INFO - 'run-tests'), 12:22:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:22:56 INFO - 'download_minidump_stackwalk': True, 12:22:56 INFO - 'download_symbols': 'ondemand', 12:22:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:22:56 INFO - 'tooltool.py': '/tools/tooltool.py', 12:22:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:22:56 INFO - '/tools/misc-python/virtualenv.py')}, 12:22:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:22:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:22:56 INFO - 'installer_path': 'installer.exe', 12:22:56 INFO - 'log_level': 'info', 12:22:56 INFO - 'log_name': 'talos', 12:22:56 INFO - 'log_to_console': True, 12:22:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:22:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:22:56 INFO - 'opt_config_files': (), 12:22:56 INFO - 'pip_index': False, 12:22:56 INFO - 'sps_profile': False, 12:22:56 INFO - 'sps_profile_interval': 0, 12:22:56 INFO - 'suite': 'dromaeojs-e10s', 12:22:56 INFO - 'system_bits': '32', 12:22:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:22:56 INFO - 'title': 'talos-linux64-ix-042', 12:22:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:22:56 INFO - 'use_talos_json': True, 12:22:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:22:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:22:56 INFO - 'work_dir': 'build'} 12:22:56 INFO - [mozharness: 2016-09-29 19:22:56.282175Z] Running clobber step. 12:22:56 INFO - Running pre-action listener: _resource_record_pre_action 12:22:56 INFO - Running main action method: clobber 12:22:56 INFO - rmtree: /builds/slave/test/build 12:22:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:22:56 INFO - Running post-action listener: _resource_record_post_action 12:22:56 INFO - [mozharness: 2016-09-29 19:22:56.744326Z] Finished clobber step (success) 12:22:56 INFO - [mozharness: 2016-09-29 19:22:56.744428Z] Running read-buildbot-config step. 12:22:56 INFO - Running pre-action listener: _resource_record_pre_action 12:22:56 INFO - Running main action method: read_buildbot_config 12:22:56 INFO - Using buildbot properties: 12:22:56 INFO - { 12:22:56 INFO - "project": "", 12:22:56 INFO - "product": "firefox", 12:22:56 INFO - "script_repo_revision": "production", 12:22:56 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:22:56 INFO - "repository": "", 12:22:56 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 12:22:56 INFO - "buildid": "20160929100439", 12:22:56 INFO - "pgo_build": "False", 12:22:56 INFO - "basedir": "/builds/slave/test", 12:22:56 INFO - "buildnumber": 1607, 12:22:56 INFO - "slavename": "talos-linux64-ix-042", 12:22:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:22:56 INFO - "platform": "ubuntu64_hw", 12:22:56 INFO - "scheduler": "tests-fx-team-linux64-talos-8-3600", 12:22:56 INFO - "branch": "fx-team", 12:22:56 INFO - "repo_path": "integration/fx-team", 12:22:56 INFO - "revision": "1723fbc9d9d88a5fbf1c57cdd1e226e36f04c522", 12:22:56 INFO - "stage_platform": "linux64", 12:22:56 INFO - "builduid": "c742fcd76585495ba700dfddc77615dd", 12:22:56 INFO - "slavebuilddir": "test" 12:22:56 INFO - } 12:22:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:22:56 INFO - Running post-action listener: _resource_record_post_action 12:22:56 INFO - [mozharness: 2016-09-29 19:22:56.746863Z] Finished read-buildbot-config step (success) 12:22:56 INFO - [mozharness: 2016-09-29 19:22:56.746952Z] Running download-and-extract step. 12:22:56 INFO - Running pre-action listener: _resource_record_pre_action 12:22:56 INFO - Running main action method: download_and_extract 12:22:56 INFO - mkdir: /builds/slave/test/build/tests 12:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:56 INFO - trying https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:22:56 INFO - Downloading https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:22:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:22:57 INFO - Downloaded 1361 bytes. 12:22:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:22:57 INFO - Using the following test package requirements: 12:22:57 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:22:57 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:22:57 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:22:57 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:57 INFO - u'jsshell-linux-x86_64.zip'], 12:22:57 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:22:57 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:22:57 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:22:57 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:22:57 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:22:57 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:22:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:22:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:22:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:22:57 INFO - Fetch https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:22:57 INFO - Http code: 200 12:22:57 INFO - Content-Encoding: None 12:22:57 INFO - Content-Type: application/zip 12:22:57 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 12:22:57 INFO - x-amz-cf-id: lgF2X11xlFPTVgbC58Brsy5ee4QKSc7s6FO4jc0Qz2N2oCF70LtzHg== 12:22:57 INFO - x-amz-version-id: aWkDNBmpAGw7gKxNpzefTJ2ivRE5cq21 12:22:57 INFO - x-cache: Hit from cloudfront 12:22:58 INFO - Expected file size: 20417233 12:22:58 INFO - Obtained file size: 20417233 12:23:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:23:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:23:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:23:02 INFO - Fetch https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:23:02 INFO - Http code: 200 12:23:02 INFO - Content-Encoding: None 12:23:02 INFO - Content-Type: application/zip 12:23:02 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 12:23:02 INFO - x-amz-cf-id: xzYYEK5ddTwej5ho_lXBpR1wXNN3sHAAGDr0BC9rd3klU0Xf2TdoSg== 12:23:02 INFO - x-amz-version-id: aWkDNBmpAGw7gKxNpzefTJ2ivRE5cq21 12:23:02 INFO - x-cache: Hit from cloudfront 12:23:02 INFO - Expected file size: 20417233 12:23:02 INFO - Obtained file size: 20417233 12:23:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:23:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:23:07 INFO - Fetch https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:23:08 INFO - Http code: 200 12:23:08 INFO - Content-Encoding: None 12:23:08 INFO - Content-Type: application/zip 12:23:08 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 12:23:08 INFO - x-amz-cf-id: rzprSfL8bZOiDBYTFeGNEbvfWJd6nr49H6MJtIrtUMHRXOh3eaQe2g== 12:23:08 INFO - x-amz-version-id: Gw0UkB_JmFZVeD_O1k5i2d_97QCQKjbZ 12:23:08 INFO - x-cache: Hit from cloudfront 12:23:08 INFO - Expected file size: 14414067 12:23:08 INFO - Obtained file size: 14414067 12:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:08 INFO - trying https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:23:08 INFO - Downloading https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:23:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:23:09 INFO - Downloaded 55744855 bytes. 12:23:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:23:09 INFO - mkdir: /builds/slave/test/properties 12:23:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:23:09 INFO - Writing to file /builds/slave/test/properties/build_url 12:23:09 INFO - Contents: 12:23:09 INFO - build_url:https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:23:10 INFO - Running post-action listener: _resource_record_post_action 12:23:10 INFO - Running post-action listener: set_extra_try_arguments 12:23:10 INFO - [mozharness: 2016-09-29 19:23:10.262004Z] Finished download-and-extract step (success) 12:23:10 INFO - [mozharness: 2016-09-29 19:23:10.262228Z] Running populate-webroot step. 12:23:10 INFO - Running pre-action listener: _resource_record_pre_action 12:23:10 INFO - Running main action method: populate_webroot 12:23:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:23:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:23:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:23:10 INFO - '--tppagecycles', 12:23:10 INFO - '7'], 12:23:10 INFO - 'tests': ['tsvgm']}}, 12:23:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:23:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:23:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:23:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:23:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:23:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:23:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:10 INFO - 'talos_options': ['--disable-e10s'], 12:23:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:23:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:23:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:10 INFO - 'talos_options': ['--disable-e10s'], 12:23:10 INFO - 'tests': ['damp', 'tps']}, 12:23:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:10 INFO - 'tests': ['damp', 'tps']}, 12:23:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:23:10 INFO - 'tests': ['dromaeo_dom']}, 12:23:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:23:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:23:10 INFO - 'tests': ['basic_compositor_video']}, 12:23:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:23:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:23:10 INFO - 'tests': ['a11yr', 12:23:10 INFO - 'ts_paint', 12:23:10 INFO - 'tpaint', 12:23:10 INFO - 'sessionrestore', 12:23:10 INFO - 'sessionrestore_no_auto_restore', 12:23:10 INFO - 'tabpaint']}, 12:23:10 INFO - 'other-e10s': {'tests': ['a11yr', 12:23:10 INFO - 'ts_paint', 12:23:10 INFO - 'tpaint', 12:23:10 INFO - 'sessionrestore', 12:23:10 INFO - 'sessionrestore_no_auto_restore', 12:23:10 INFO - 'tabpaint']}, 12:23:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:23:10 INFO - 'ts_paint', 12:23:10 INFO - 'tpaint', 12:23:10 INFO - 'sessionrestore', 12:23:10 INFO - 'sessionrestore_no_auto_restore', 12:23:10 INFO - 'tabpaint']}, 12:23:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:23:10 INFO - 'ts_paint', 12:23:10 INFO - 'tpaint', 12:23:10 INFO - 'sessionrestore', 12:23:10 INFO - 'sessionrestore_no_auto_restore', 12:23:10 INFO - 'tabpaint']}, 12:23:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:23:10 INFO - 'tests': ['a11yr', 12:23:10 INFO - 'ts_paint', 12:23:10 INFO - 'tpaint', 12:23:10 INFO - 'sessionrestore', 12:23:10 INFO - 'sessionrestore_no_auto_restore', 12:23:10 INFO - 'tabpaint']}, 12:23:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:23:10 INFO - 'tests': ['a11yr', 12:23:10 INFO - 'ts_paint', 12:23:10 INFO - 'tpaint', 12:23:10 INFO - 'sessionrestore', 12:23:10 INFO - 'sessionrestore_no_auto_restore', 12:23:10 INFO - 'tabpaint']}, 12:23:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:23:10 INFO - 'tests': ['tsvgx', 12:23:10 INFO - 'tsvgr_opacity', 12:23:10 INFO - 'tart', 12:23:10 INFO - 'tscrollx', 12:23:10 INFO - 'cart']}, 12:23:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:23:10 INFO - 'tsvgr_opacity', 12:23:10 INFO - 'tart', 12:23:10 INFO - 'tscrollx', 12:23:10 INFO - 'cart']}, 12:23:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:10 INFO - 'talos_options': ['--disable-e10s'], 12:23:10 INFO - 'tests': ['tp5o']}, 12:23:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:10 INFO - 'tests': ['tp5o']}, 12:23:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:10 INFO - 'talos_options': ['--disable-e10s', 12:23:10 INFO - '--xperf_path', 12:23:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:23:10 INFO - 'tests': ['tp5n']}, 12:23:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:10 INFO - 'talos_options': ['--xperf_path', 12:23:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:23:10 INFO - 'tests': ['tp5n']}}, 12:23:10 INFO - 'talos.zip': {'path': '', 12:23:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:23:10 INFO - Running post-action listener: _resource_record_post_action 12:23:10 INFO - [mozharness: 2016-09-29 19:23:10.281244Z] Finished populate-webroot step (success) 12:23:10 INFO - [mozharness: 2016-09-29 19:23:10.281332Z] Running create-virtualenv step. 12:23:10 INFO - Running pre-action listener: _resource_record_pre_action 12:23:10 INFO - Running main action method: create_virtualenv 12:23:10 INFO - Creating virtualenv /builds/slave/test/build/venv 12:23:10 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 12:23:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:23:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:23:10 INFO - Using real prefix '/usr' 12:23:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:23:10 INFO - Installing distribute.............................................................................................................................................................................................done. 12:23:12 INFO - Installing pip.................done. 12:23:12 INFO - Return code: 0 12:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:23:13 INFO - Reading from file tmpfile_stdout 12:23:13 INFO - Output received: 12:23:13 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:23:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:23:13 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:13 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:13 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 0x7f2b3aedef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1680ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167df60>, '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 0x167ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', '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 12:23:13 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 12:23:13 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 12:23:13 INFO - Using env: {'DISPLAY': ':0', 12:23:13 INFO - 'HOME': '/home/cltbld', 12:23:13 INFO - 'LANG': 'en_US.UTF-8', 12:23:13 INFO - 'LANGUAGE': 'en_US:en', 12:23:13 INFO - 'LOGNAME': 'cltbld', 12:23:13 INFO - 'MAIL': '/var/mail/cltbld', 12:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:13 INFO - 'MOZ_NO_REMOTE': '1', 12:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:13 INFO - 'NO_EM_RESTART': '1', 12:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:13 INFO - 'PWD': '/builds/slave/test', 12:23:13 INFO - 'SHELL': '/bin/bash', 12:23:13 INFO - 'SHLVL': '1', 12:23:13 INFO - 'TERM': 'linux', 12:23:13 INFO - 'TMOUT': '86400', 12:23:13 INFO - 'USER': 'cltbld', 12:23:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', 12:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:13 INFO - '_': '/tools/buildbot/bin/python'} 12:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:13 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 12:23:13 INFO - Cleaning up... 12:23:13 INFO - Return code: 0 12:23:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:23:13 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:13 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:13 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b3aedef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1680ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167df60>, '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 0x167ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', '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 12:23:13 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>=3.1.1'] in /builds/slave/test/build 12:23:13 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>=3.1.1 12:23:13 INFO - Using env: {'DISPLAY': ':0', 12:23:13 INFO - 'HOME': '/home/cltbld', 12:23:13 INFO - 'LANG': 'en_US.UTF-8', 12:23:13 INFO - 'LANGUAGE': 'en_US:en', 12:23:13 INFO - 'LOGNAME': 'cltbld', 12:23:13 INFO - 'MAIL': '/var/mail/cltbld', 12:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:13 INFO - 'MOZ_NO_REMOTE': '1', 12:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:13 INFO - 'NO_EM_RESTART': '1', 12:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:13 INFO - 'PWD': '/builds/slave/test', 12:23:13 INFO - 'SHELL': '/bin/bash', 12:23:13 INFO - 'SHLVL': '1', 12:23:13 INFO - 'TERM': 'linux', 12:23:13 INFO - 'TMOUT': '86400', 12:23:13 INFO - 'USER': 'cltbld', 12:23:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', 12:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:13 INFO - '_': '/tools/buildbot/bin/python'} 12:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:13 INFO - Downloading/unpacking psutil>=3.1.1 12:23:13 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 12:23:13 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 12:23:13 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 12:23:13 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 12:23:13 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 12:23:13 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 12:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:23:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:23:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:23:15 INFO - Installing collected packages: psutil 12:23:15 INFO - Running setup.py install for psutil 12:23:15 INFO - building 'psutil._psutil_linux' extension 12:23:15 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 12:23:15 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 12:23:15 INFO - building 'psutil._psutil_posix' extension 12:23:15 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 12:23:15 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 12:23:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:23:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:23:16 INFO - Successfully installed psutil 12:23:16 INFO - Cleaning up... 12:23:16 INFO - Return code: 0 12:23:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:23:16 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:16 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:16 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b3aedef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1680ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167df60>, '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 0x167ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', '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 12:23:16 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.3'] in /builds/slave/test/build 12:23:16 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.3 12:23:16 INFO - Using env: {'DISPLAY': ':0', 12:23:16 INFO - 'HOME': '/home/cltbld', 12:23:16 INFO - 'LANG': 'en_US.UTF-8', 12:23:16 INFO - 'LANGUAGE': 'en_US:en', 12:23:16 INFO - 'LOGNAME': 'cltbld', 12:23:16 INFO - 'MAIL': '/var/mail/cltbld', 12:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:16 INFO - 'MOZ_NO_REMOTE': '1', 12:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:16 INFO - 'NO_EM_RESTART': '1', 12:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:16 INFO - 'PWD': '/builds/slave/test', 12:23:16 INFO - 'SHELL': '/bin/bash', 12:23:16 INFO - 'SHLVL': '1', 12:23:16 INFO - 'TERM': 'linux', 12:23:16 INFO - 'TMOUT': '86400', 12:23:16 INFO - 'USER': 'cltbld', 12:23:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', 12:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:16 INFO - '_': '/tools/buildbot/bin/python'} 12:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:23:18 INFO - Installing collected packages: mozsystemmonitor 12:23:18 INFO - Running setup.py install for mozsystemmonitor 12:23:18 INFO - Successfully installed mozsystemmonitor 12:23:18 INFO - Cleaning up... 12:23:18 INFO - Return code: 0 12:23:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:23:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:18 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b3aedef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1680ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167df60>, '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 0x167ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', '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 12:23:18 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==2.5.1'] in /builds/slave/test/build 12:23:18 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==2.5.1 12:23:18 INFO - Using env: {'DISPLAY': ':0', 12:23:18 INFO - 'HOME': '/home/cltbld', 12:23:18 INFO - 'LANG': 'en_US.UTF-8', 12:23:18 INFO - 'LANGUAGE': 'en_US:en', 12:23:18 INFO - 'LOGNAME': 'cltbld', 12:23:18 INFO - 'MAIL': '/var/mail/cltbld', 12:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:18 INFO - 'MOZ_NO_REMOTE': '1', 12:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:18 INFO - 'NO_EM_RESTART': '1', 12:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:18 INFO - 'PWD': '/builds/slave/test', 12:23:18 INFO - 'SHELL': '/bin/bash', 12:23:18 INFO - 'SHLVL': '1', 12:23:18 INFO - 'TERM': 'linux', 12:23:18 INFO - 'TMOUT': '86400', 12:23:18 INFO - 'USER': 'cltbld', 12:23:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', 12:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:18 INFO - '_': '/tools/buildbot/bin/python'} 12:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:18 INFO - Downloading/unpacking jsonschema==2.5.1 12:23:18 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 12:23:18 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 12:23:18 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 12:23:18 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 12:23:18 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 12:23:18 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 12:23:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:23:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:23:20 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 12:23:20 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 12:23:20 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 12:23:20 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 12:23:20 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 12:23:20 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 12:23:20 INFO - Downloading functools32-3.2.3-2.tar.gz 12:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:23:20 INFO - warning: no files found matching '*.txt' 12:23:20 INFO - no previously-included directories found matching 'build' 12:23:20 INFO - no previously-included directories found matching 'dist' 12:23:20 INFO - no previously-included directories found matching '.git*' 12:23:20 INFO - Installing collected packages: jsonschema, functools32 12:23:20 INFO - Running setup.py install for functools32 12:23:20 INFO - warning: no files found matching '*.txt' 12:23:20 INFO - no previously-included directories found matching 'build' 12:23:20 INFO - no previously-included directories found matching 'dist' 12:23:20 INFO - no previously-included directories found matching '.git*' 12:23:20 INFO - Successfully installed jsonschema functools32 12:23:20 INFO - Cleaning up... 12:23:20 INFO - Return code: 0 12:23:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:23:20 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:20 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:20 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b3aedef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1680ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167df60>, '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 0x167ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', '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 12:23:20 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:23:20 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 functools32==3.2.3-2 12:23:20 INFO - Using env: {'DISPLAY': ':0', 12:23:20 INFO - 'HOME': '/home/cltbld', 12:23:20 INFO - 'LANG': 'en_US.UTF-8', 12:23:20 INFO - 'LANGUAGE': 'en_US:en', 12:23:20 INFO - 'LOGNAME': 'cltbld', 12:23:20 INFO - 'MAIL': '/var/mail/cltbld', 12:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:20 INFO - 'MOZ_NO_REMOTE': '1', 12:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:20 INFO - 'NO_EM_RESTART': '1', 12:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:20 INFO - 'PWD': '/builds/slave/test', 12:23:20 INFO - 'SHELL': '/bin/bash', 12:23:20 INFO - 'SHLVL': '1', 12:23:20 INFO - 'TERM': 'linux', 12:23:20 INFO - 'TMOUT': '86400', 12:23:20 INFO - 'USER': 'cltbld', 12:23:20 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', 12:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:20 INFO - '_': '/tools/buildbot/bin/python'} 12:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:23:21 INFO - Cleaning up... 12:23:21 INFO - Return code: 0 12:23:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:21 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 0x7f2b3aedef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1680ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167df60>, '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 0x167ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', '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 12:23:21 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 12:23:21 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 12:23:21 INFO - Using env: {'DISPLAY': ':0', 12:23:21 INFO - 'HOME': '/home/cltbld', 12:23:21 INFO - 'LANG': 'en_US.UTF-8', 12:23:21 INFO - 'LANGUAGE': 'en_US:en', 12:23:21 INFO - 'LOGNAME': 'cltbld', 12:23:21 INFO - 'MAIL': '/var/mail/cltbld', 12:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:21 INFO - 'MOZ_NO_REMOTE': '1', 12:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:21 INFO - 'NO_EM_RESTART': '1', 12:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:21 INFO - 'PWD': '/builds/slave/test', 12:23:21 INFO - 'SHELL': '/bin/bash', 12:23:21 INFO - 'SHLVL': '1', 12:23:21 INFO - 'TERM': 'linux', 12:23:21 INFO - 'TMOUT': '86400', 12:23:21 INFO - 'USER': 'cltbld', 12:23:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', 12:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:21 INFO - '_': '/tools/buildbot/bin/python'} 12:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:21 INFO - Downloading/unpacking blobuploader==1.2.4 12:23:21 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 12:23:21 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 12:23:21 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 12:23:21 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 12:23:21 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 12:23:21 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 12:23:23 INFO - Downloading blobuploader-1.2.4.tar.gz 12:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:23:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:23:23 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 12:23:23 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 12:23:23 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 12:23:23 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 12:23:23 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 12:23:23 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 12:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:23:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:23:23 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 12:23:23 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 12:23:23 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 12:23:23 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 12:23:23 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 12:23:23 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 12:23:24 INFO - Downloading docopt-0.6.1.tar.gz 12:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:23:24 INFO - Installing collected packages: blobuploader, requests, docopt 12:23:24 INFO - Running setup.py install for blobuploader 12:23:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:23:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:23:24 INFO - Running setup.py install for requests 12:23:24 INFO - Running setup.py install for docopt 12:23:24 INFO - Successfully installed blobuploader requests docopt 12:23:24 INFO - Cleaning up... 12:23:24 INFO - Return code: 0 12:23:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:24 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 0x7f2b3aedef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1680ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167df60>, '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 0x167ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', '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 12:23:24 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 12:23:24 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 12:23:24 INFO - Using env: {'DISPLAY': ':0', 12:23:24 INFO - 'HOME': '/home/cltbld', 12:23:24 INFO - 'LANG': 'en_US.UTF-8', 12:23:24 INFO - 'LANGUAGE': 'en_US:en', 12:23:24 INFO - 'LOGNAME': 'cltbld', 12:23:24 INFO - 'MAIL': '/var/mail/cltbld', 12:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:24 INFO - 'MOZ_NO_REMOTE': '1', 12:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:24 INFO - 'NO_EM_RESTART': '1', 12:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:24 INFO - 'PWD': '/builds/slave/test', 12:23:24 INFO - 'SHELL': '/bin/bash', 12:23:24 INFO - 'SHLVL': '1', 12:23:24 INFO - 'TERM': 'linux', 12:23:24 INFO - 'TMOUT': '86400', 12:23:24 INFO - 'USER': 'cltbld', 12:23:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', 12:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:24 INFO - '_': '/tools/buildbot/bin/python'} 12:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:23:24 INFO - Running setup.py (path:/tmp/pip-Y0RNHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:23:24 INFO - Running setup.py (path:/tmp/pip-J8aAog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:23:25 INFO - Running setup.py (path:/tmp/pip-63ZWoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:23:25 INFO - Running setup.py (path:/tmp/pip-ECEkWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:23:25 INFO - Running setup.py (path:/tmp/pip-HFgPVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:23:25 INFO - Running setup.py (path:/tmp/pip-Xnnm3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:23:25 INFO - Running setup.py (path:/tmp/pip-snXDf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:23:25 INFO - Running setup.py (path:/tmp/pip-HFj2Hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:23:25 INFO - Running setup.py (path:/tmp/pip-nrPzFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:23:25 INFO - Running setup.py (path:/tmp/pip-vukDRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:23:25 INFO - Running setup.py (path:/tmp/pip-ztfIdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:23:25 INFO - Running setup.py (path:/tmp/pip-gEloqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:23:25 INFO - Running setup.py (path:/tmp/pip-YIKLo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:23:25 INFO - Running setup.py (path:/tmp/pip-eL_Wlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:25 INFO - Running setup.py (path:/tmp/pip-lFD4ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:23:26 INFO - Running setup.py (path:/tmp/pip-aj7jNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:23:26 INFO - Running setup.py (path:/tmp/pip-ABQGdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:23:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:23:26 INFO - Running setup.py install for manifestparser 12:23:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Running setup.py install for mozcrash 12:23:26 INFO - Running setup.py install for mozdebug 12:23:26 INFO - Running setup.py install for mozdevice 12:23:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Running setup.py install for mozfile 12:23:26 INFO - Running setup.py install for mozhttpd 12:23:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Running setup.py install for mozinfo 12:23:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Running setup.py install for mozInstall 12:23:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Running setup.py install for mozleak 12:23:27 INFO - Running setup.py install for mozlog 12:23:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:23:27 INFO - Running setup.py install for moznetwork 12:23:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:23:27 INFO - Running setup.py install for mozprocess 12:23:27 INFO - Running setup.py install for mozprofile 12:23:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:23:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:23:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:23:27 INFO - Running setup.py install for mozrunner 12:23:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:23:27 INFO - Running setup.py install for mozscreenshot 12:23:27 INFO - Running setup.py install for moztest 12:23:27 INFO - Running setup.py install for mozversion 12:23:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:23:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:23:27 INFO - Cleaning up... 12:23:27 INFO - Return code: 0 12:23:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:27 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 0x7f2b3aedef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1680ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167df60>, '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 0x167ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', '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 12:23:27 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 12:23:27 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 12:23:27 INFO - Using env: {'DISPLAY': ':0', 12:23:27 INFO - 'HOME': '/home/cltbld', 12:23:27 INFO - 'LANG': 'en_US.UTF-8', 12:23:27 INFO - 'LANGUAGE': 'en_US:en', 12:23:27 INFO - 'LOGNAME': 'cltbld', 12:23:27 INFO - 'MAIL': '/var/mail/cltbld', 12:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:27 INFO - 'MOZ_NO_REMOTE': '1', 12:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:27 INFO - 'NO_EM_RESTART': '1', 12:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:27 INFO - 'PWD': '/builds/slave/test', 12:23:27 INFO - 'SHELL': '/bin/bash', 12:23:27 INFO - 'SHLVL': '1', 12:23:27 INFO - 'TERM': 'linux', 12:23:27 INFO - 'TMOUT': '86400', 12:23:27 INFO - 'USER': 'cltbld', 12:23:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', 12:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:27 INFO - '_': '/tools/buildbot/bin/python'} 12:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:23:28 INFO - Running setup.py (path:/tmp/pip-NSJnrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:23:28 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)) 12:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:23:28 INFO - Running setup.py (path:/tmp/pip-TVvWVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:23:28 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)) 12:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:23:28 INFO - Running setup.py (path:/tmp/pip-VKDRzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:23:28 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)) 12:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:23:28 INFO - Running setup.py (path:/tmp/pip-RnYCh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:23:28 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)) 12:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:23:28 INFO - Running setup.py (path:/tmp/pip-1jDhJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:23:28 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)) 12:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:23:28 INFO - Running setup.py (path:/tmp/pip-PcKJYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:23:28 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)) 12:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:23:28 INFO - Running setup.py (path:/tmp/pip-FfWtT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:23:28 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)) 12:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:23:28 INFO - Running setup.py (path:/tmp/pip-7v86Ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:23:28 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)) 12:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:23:28 INFO - Running setup.py (path:/tmp/pip-FTBXoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:23:28 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)) 12:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:23:28 INFO - Running setup.py (path:/tmp/pip-U5jbGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:23:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 12:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:23:28 INFO - Running setup.py (path:/tmp/pip-HjHiIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:23:28 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)) 12:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:23:28 INFO - Running setup.py (path:/tmp/pip-Hosiaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 12:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:23:29 INFO - Running setup.py (path:/tmp/pip-UwAks6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:23:29 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)) 12:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:23:29 INFO - Running setup.py (path:/tmp/pip-Zagi__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 12:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:29 INFO - Running setup.py (path:/tmp/pip-uLq1tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:29 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)) 12:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:23:29 INFO - Running setup.py (path:/tmp/pip-bSv8TE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:23:29 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)) 12:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:23:29 INFO - Running setup.py (path:/tmp/pip-jxYz01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:23:29 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)) 12:23:29 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)) 12:23:29 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)) 12:23:29 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)) 12:23:29 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)) 12:23:29 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)) 12:23:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:31 INFO - Downloading blessings-1.6.tar.gz 12:23:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:23:31 INFO - Installing collected packages: blessings 12:23:31 INFO - Running setup.py install for blessings 12:23:31 INFO - Successfully installed blessings 12:23:31 INFO - Cleaning up... 12:23:31 INFO - Return code: 0 12:23:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:23:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:23:31 INFO - Reading from file tmpfile_stdout 12:23:31 INFO - Current package versions: 12:23:31 INFO - argparse == 1.2.1 12:23:31 INFO - blessings == 1.6 12:23:31 INFO - blobuploader == 1.2.4 12:23:31 INFO - docopt == 0.6.1 12:23:31 INFO - functools32 == 3.2.3-2 12:23:31 INFO - jsonschema == 2.5.1 12:23:31 INFO - manifestparser == 1.1 12:23:31 INFO - mozInstall == 1.12 12:23:31 INFO - mozcrash == 0.17 12:23:31 INFO - mozdebug == 0.1 12:23:31 INFO - mozdevice == 0.48 12:23:31 INFO - mozfile == 1.2 12:23:31 INFO - mozhttpd == 0.7 12:23:31 INFO - mozinfo == 0.9 12:23:31 INFO - mozleak == 0.1 12:23:31 INFO - mozlog == 3.4 12:23:31 INFO - moznetwork == 0.27 12:23:31 INFO - mozprocess == 0.23 12:23:31 INFO - mozprofile == 0.28 12:23:31 INFO - mozrunner == 6.12 12:23:31 INFO - mozscreenshot == 0.1 12:23:31 INFO - mozsystemmonitor == 0.3 12:23:31 INFO - moztest == 0.7 12:23:31 INFO - mozversion == 1.4 12:23:31 INFO - psutil == 3.1.1 12:23:31 INFO - requests == 1.2.3 12:23:31 INFO - wsgiref == 0.1.2 12:23:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:23:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:31 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 0x7f2b3aedef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1680ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167df60>, '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 0x167ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', '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 12:23:31 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 12:23:31 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 12:23:31 INFO - Using env: {'DISPLAY': ':0', 12:23:31 INFO - 'HOME': '/home/cltbld', 12:23:31 INFO - 'LANG': 'en_US.UTF-8', 12:23:31 INFO - 'LANGUAGE': 'en_US:en', 12:23:31 INFO - 'LOGNAME': 'cltbld', 12:23:31 INFO - 'MAIL': '/var/mail/cltbld', 12:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:31 INFO - 'MOZ_NO_REMOTE': '1', 12:23:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:31 INFO - 'NO_EM_RESTART': '1', 12:23:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:31 INFO - 'PWD': '/builds/slave/test', 12:23:31 INFO - 'SHELL': '/bin/bash', 12:23:31 INFO - 'SHLVL': '1', 12:23:31 INFO - 'TERM': 'linux', 12:23:31 INFO - 'TMOUT': '86400', 12:23:31 INFO - 'USER': 'cltbld', 12:23:31 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', 12:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:31 INFO - '_': '/tools/buildbot/bin/python'} 12:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:32 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)) 12:23:32 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)) 12:23:32 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)) 12:23:32 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)) 12:23:32 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)) 12:23:32 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)) 12:23:32 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)) 12:23:32 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)) 12:23:32 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)) 12:23:32 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)) 12:23:32 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)) 12:23:32 INFO - Cleaning up... 12:23:32 INFO - Return code: 0 12:23:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b3aedef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1680ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167df60>, '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 0x167ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', '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 12:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:23:32 INFO - Using env: {'DISPLAY': ':0', 12:23:32 INFO - 'HOME': '/home/cltbld', 12:23:32 INFO - 'LANG': 'en_US.UTF-8', 12:23:32 INFO - 'LANGUAGE': 'en_US:en', 12:23:32 INFO - 'LOGNAME': 'cltbld', 12:23:32 INFO - 'MAIL': '/var/mail/cltbld', 12:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:32 INFO - 'MOZ_NO_REMOTE': '1', 12:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:32 INFO - 'NO_EM_RESTART': '1', 12:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:32 INFO - 'PWD': '/builds/slave/test', 12:23:32 INFO - 'SHELL': '/bin/bash', 12:23:32 INFO - 'SHLVL': '1', 12:23:32 INFO - 'TERM': 'linux', 12:23:32 INFO - 'TMOUT': '86400', 12:23:32 INFO - 'USER': 'cltbld', 12:23:32 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', 12:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:32 INFO - '_': '/tools/buildbot/bin/python'} 12:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:23:32 INFO - Cleaning up... 12:23:32 INFO - Return code: 0 12:23:32 INFO - Running post-action listener: _resource_record_post_action 12:23:32 INFO - Running post-action listener: _start_resource_monitoring 12:23:32 INFO - Starting resource monitoring. 12:23:32 INFO - [mozharness: 2016-09-29 19:23:32.297627Z] Finished create-virtualenv step (success) 12:23:32 INFO - [mozharness: 2016-09-29 19:23:32.298130Z] Running install step. 12:23:32 INFO - Running pre-action listener: _resource_record_pre_action 12:23:32 INFO - Running main action method: install 12:23:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:23:32 INFO - Reading from file tmpfile_stdout 12:23:32 INFO - Detecting whether we're running mozinstall >=1.0... 12:23:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:23:32 INFO - Reading from file tmpfile_stdout 12:23:32 INFO - Output received: 12:23:32 INFO - Usage: mozinstall [options] installer 12:23:32 INFO - Options: 12:23:32 INFO - -h, --help show this help message and exit 12:23:32 INFO - -d DEST, --destination=DEST 12:23:32 INFO - Directory to install application into. [default: 12:23:32 INFO - "/builds/slave/test"] 12:23:32 INFO - --app=APP Application being installed. [default: firefox] 12:23:32 INFO - mkdir: /builds/slave/test/build/application 12:23:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:23:48 INFO - Reading from file tmpfile_stdout 12:23:48 INFO - Output received: 12:23:48 INFO - /builds/slave/test/build/application/firefox/firefox 12:23:48 INFO - Running post-action listener: _resource_record_post_action 12:23:48 INFO - [mozharness: 2016-09-29 19:23:48.690348Z] Finished install step (success) 12:23:48 INFO - [mozharness: 2016-09-29 19:23:48.690592Z] Running run-tests step. 12:23:48 INFO - Running pre-action listener: _resource_record_pre_action 12:23:48 INFO - Running main action method: run_tests 12:23:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:23:48 INFO - Python 2.7.3 12:23:48 INFO - Return code: 0 12:23:48 INFO - grabbing minidump binary from tooltool 12:23:48 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:48 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167df60>, '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 0x167ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:23:48 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 12:23:48 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 12:23:48 INFO - Calling ['/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'] with output_timeout 600 12:23:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:23:48 INFO - Return code: 0 12:23:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:23:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:23:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:23:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:23:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:23:48 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:23:48 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:23:48 INFO - Using env: {'DISPLAY': ':0', 12:23:48 INFO - 'HOME': '/home/cltbld', 12:23:48 INFO - 'LANG': 'en_US.UTF-8', 12:23:48 INFO - 'LANGUAGE': 'en_US:en', 12:23:48 INFO - 'LOGNAME': 'cltbld', 12:23:48 INFO - 'MAIL': '/var/mail/cltbld', 12:23:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:23:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:48 INFO - 'MOZ_NO_REMOTE': '1', 12:23:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:23:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:48 INFO - 'NO_EM_RESTART': '1', 12:23:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:48 INFO - 'PWD': '/builds/slave/test', 12:23:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:23:48 INFO - 'SHELL': '/bin/bash', 12:23:48 INFO - 'SHLVL': '1', 12:23:48 INFO - 'TERM': 'linux', 12:23:48 INFO - 'TMOUT': '86400', 12:23:48 INFO - 'USER': 'cltbld', 12:23:48 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503', 12:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:48 INFO - '_': '/tools/buildbot/bin/python'} 12:23:48 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:23:48 INFO - mozversion application_buildid: 20160929100439 12:23:48 INFO - mozversion application_changeset: 1723fbc9d9d88a5fbf1c57cdd1e226e36f04c522 12:23:48 INFO - mozversion application_display_name: Nightly 12:23:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:23:48 INFO - mozversion application_name: Firefox 12:23:48 INFO - mozversion application_remotingname: firefox 12:23:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:23:48 INFO - mozversion application_vendor: Mozilla 12:23:48 INFO - mozversion application_version: 52.0a1 12:23:48 INFO - mozversion platform_buildid: 20160929100439 12:23:48 INFO - mozversion platform_changeset: 1723fbc9d9d88a5fbf1c57cdd1e226e36f04c522 12:23:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:23:48 INFO - mozversion platform_version: 52.0a1 12:23:48 INFO - using testdate: 1475177028 12:23:48 INFO - actual date: 1475177028 12:23:48 INFO - starting webserver on 'localhost:38352' 12:23:48 INFO - SUITE-START | Running 2 tests 12:23:48 INFO - TEST-START | dromaeo_css 12:23:48 INFO - operating with platform_type : linux_ 12:23:48 INFO - Initialising browser for dromaeo_css test... 12:23:48 INFO - TEST-INFO | started process 9622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUlzAPR/profile http://localhost:38352/getInfo.html) 12:23:53 INFO - PROCESS | 9622 | __metrics Screen width/height:1600/1200 12:23:53 INFO - PROCESS | 9622 | colorDepth:24 12:23:53 INFO - PROCESS | 9622 | Browser inner width/height: 1024/697 12:23:53 INFO - PROCESS | 9622 | __metrics 12:23:54 ERROR - PROCESS | 9622 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 12:23:55 INFO - TEST-INFO | 9622: exit 0 12:23:55 INFO - Browser initialized. 12:23:55 INFO - Running cycle 1/1 for dromaeo_css test... 12:23:55 INFO - TEST-INFO | started process 9745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUlzAPR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:24:07 INFO - PROCESS | 9745 | RSS: Main: 186306560 12:24:07 INFO - PROCESS | 9745 | 12:24:57 INFO - PROCESS | 9745 | 1475177097442 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] 12:27:10 INFO - PROCESS | 9745 | Cycle 1(1): loaded http://localhost:38352/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38352/tests/dromaeo/cssquery-ext.html) 12:27:11 INFO - PROCESS | 9745 | RSS: Main: 200278016 12:27:11 INFO - PROCESS | 9745 | 12:30:13 INFO - PROCESS | 9745 | Cycle 1(1): loaded http://localhost:38352/tests/dromaeo/cssquery-ext.html (next: http://localhost:38352/tests/dromaeo/cssquery-jquery.html) 12:30:14 INFO - PROCESS | 9745 | RSS: Main: 197193728 12:30:14 INFO - PROCESS | 9745 | 12:33:16 INFO - PROCESS | 9745 | Cycle 1(1): loaded http://localhost:38352/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38352/tests/dromaeo/cssquery-mootools.html) 12:33:17 INFO - PROCESS | 9745 | RSS: Main: 198754304 12:33:17 INFO - PROCESS | 9745 | 12:36:19 INFO - PROCESS | 9745 | Cycle 1(1): loaded http://localhost:38352/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38352/tests/dromaeo/cssquery-prototype.html) 12:36:19 INFO - PROCESS | 9745 | RSS: Main: 196145152 12:36:19 INFO - PROCESS | 9745 | 12:39:22 INFO - PROCESS | 9745 | Cycle 1(1): loaded http://localhost:38352/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38352/tests/dromaeo/cssquery-yui.html) 12:39:23 INFO - PROCESS | 9745 | RSS: Main: 199032832 12:39:23 INFO - PROCESS | 9745 | 12:42:25 INFO - PROCESS | 9745 | Cycle 1(1): loaded http://localhost:38352/tests/dromaeo/cssquery-yui.html (next: http://localhost:38352/tests/dromaeo/cssquery-dojo.html) 12:42:26 INFO - PROCESS | 9745 | RSS: Main: 199778304 12:42:26 INFO - PROCESS | 9745 | 12:42:26 INFO - PROCESS | 9745 | __start_tp_report 12:42:26 INFO - PROCESS | 9745 | _x_x_mozilla_page_load 12:42:26 INFO - PROCESS | 9745 | _x_x_mozilla_page_load_details 12:42:26 INFO - PROCESS | 9745 | |i|pagename|runs| 12:42:26 INFO - PROCESS | 9745 | |0;dojo.html;2583.444559419725;2598.0387256715007;2608.243609353288;2625.4092829113447;2652.522545941731;4591.966807468326;4755.500672429397;4773.8806529836775;4782.306565547993;4804.039192161565;4664.650151238654;4709.764511774406;4783.545563171493;4803.159447096761;4821.807127714896;4281.657467402601;4311.913761724763;4342.826286948518;4402.449693788277;4441.578050085237;4461.063176732874;4490.461144662629;4501.122281155176;4501.954980450203;4511.52628973958;4208.179405015992;4234.894127646803;4328.826846926119;4357.651387888961;4368.541303163154;4394.1651086293505;4399.296112621965;4445.222086134946;4453.465584129893;4454.48773391061;4337.479502459725;4356.760378179199;4365.9126817463475;4384.693071484998;4415.4259946206785;4591.150637132141;4634.281686338623;4698.365720627706;4755.310479980383;4837.371141751585;5088.898222035576;5090.1855703087695;5098.694078355311;5149.30484384607;5165.586753059746;5124.769385377667;5135.255387968761;5135.486451354872;5135.84592462223;5194.3247377840635;4580.65645076614;4631.536846315342;4766.833160839354;4779.498152693986;4779.928301075487;5164.096283150434;5232.816851410183;5236.1098613235845;5238.345206849144;5294.470552944675;5016.799328026838;5017.7491125443585;5029.698218106925;5034.0938631046765;5081.923771143436;4873.926891096637;4942.728149951788;4949.034938187019;5104.234364845229;5118.462561431071;5041.546260836542;5104.3109180260935;5112.258722485219;5126.307948426989;5192.247124166975;5070.285606579175;5091.08360495107;5102.107131252016;5103.413107492612;5165.354330708661;4171.499420069611;4342.826286948487;4357.9128417431475;4366.759828209415;4401.977990110093;3651.8539258429896;3733.7946412947003;3749.3813520769313;3766.0584853786554;3769.3026790043928;4349.195398851222;4405.977970110129;4422.579854913778;4455.242608756519;4457.843975460908;5137.100673415772;5149.356330458692;5149.562287205555;5154.639175257771;5217.034848553029;4207.053412982054;4261.531231564525;4392.363107349481;4401.449818772653;4459.777011149429;4598.402207713043;4622.537746225418;4645.3032045193495;4653.976730116327;4709.058188362341;4822.734749588806;4829.275608658589;4834.20235661126;4845.878853028632;4863.756812159378;4938.851834444972;5173.0688476074665;5184.899769801599;5191.143461328989;5240.502152295526;4656.720596764205;4720.645951553716;4743.335932969318;4772.6659133861685;4844.491328410466;5013.774380152829;5020.046191223656;5029.145045342374;5030.874228144326;5097.057044446789;5066.670666406671;5115.590752739847;5120.436751957356;5121.103806833715;5124.385073791169;4773.1408346497965;4821.975890120527;4832.395950506187;4893.853184404474;4923.729194894315;4925.21196608541;4953.455119936732;4960.032793605356;4998.775055122455;5010.849674509771;4706.011737535019;4733.148033354029;4837.733924634179;4860.76050607107;4917.188663870421;5022.070916880389;5051.2423136529815;5051.267566202807;5055.469175736494;5134.358205224347;4958.851234462972;4964.67729597575;4968.105740966661;4970.5029497051455;5029.597632189343 12:42:26 INFO - PROCESS | 9745 | |1;ext.html;542.7991643092055;548.9980785067253;550.5457997152349;558.3801979802416;561.1050374652428;36442.453363199544;37772.43341349882;37838.810805945934;37931.43102853453;37967.44390673116;39412;39991;40223.396649050286;40261.7986910065;40371.962803719616;7679.769606911802;7857.096433910087;7868.724594639189;7872.448928574973;7878.172791856859;7763.417743669219;7785.260400261966;7865.410094242926;7865.488743231672;7882.881756773653;7853.214678532129;7887.921120788805;7889.1716369780925;7894.2105789421175;7906.130325664172;7719.922800771977;7847.489913155627;7874.251946065115;7899.249571290718;7902.841943161105;7669.6932122715025;7685.385169186452;7701.460897737161;7714.382849372093;7741.148473667892;36745.08137296589;37008;37018.8149059253;37297.627023729685;37357.62642373596;2919.8102123362128;3055.6791536888527;3262.5921759780026;3622.9275414491826;3730.1908574341423;27284.181474555797;27501.174964751088;27524.58713119305;27710.307242319104;28577.428451431064;3496.1609213788506;3536.5792759051187;3540.2211513466996;3581.8209089545417;3582.390993531106;166345;166832;167029;167335;167342;30468.23829404238;31424.21439463986;50021.24968125481;50274;50383;32550.837245814095;32666.510002349984;32698.83650581732;32873.67126328706;32897;12508.186967847061;12706.745865082832;12742.044346674036;12743.235405875677;12747.107702460738;10403.491493733367;10423.166146708245;10432.5826966922;10435.32170408921;10466.947665261778;7700;7713.961430192925;7785.3771698264;7821.335186509211;7831.843363132705;3035.104644129987;3044.0563425338214;3067.4478593852873;3083.691630836898;3106.223444138965;816.7713040348712;838.3502785341409;866.7951547349189;889.7731078575051;1005.5625802775816;25832.354191145372;27644.58533122005;27778.305542361602;28021.71978280232;28269;893.1738142218422;898.6854600889636;936.765808547863;940.520334629344;1035.0270745499206;13893.235872027135;14668.339924703201;14959.252037398086;15032;15121.319540620698;368544;368886;369049;369184;370633;48563.75718121387;48816.26775598369;48957.75521122372;49039;49116.7544162284;1106.2201148190507;1138.703936976392;1170.403094421851;1171.0748508678048;1177.2230327983489;26414.735852641228;27167.320816979733;27180.592291116045;27935.580966285117;27952.38785600353;41470;41743.58256417397;41829.79085104555;41843.163136737705;42037.159256814084;245132;245563;246019;246098;247102;24367;24833.379165521008;24874;24895.253142405756;24956.75043249617;40064.799676001436;40904;41373.172536549704;41654.37518437165;42079;34797.652023479444;35038.64961350456;35095.649043509235;35194.82402587971;35243;34443.655563444045;34685.65314346824;34794.478082829286;34948;35206.64793352034;24787.504249915262;28265.71734282713;32586.674133259312;33027.83486082554;34977.12557186091;29449.705502944696;31563.684363156994;32405.35189296154;32464.83767581147;32510.837445813566;24277.393065173514;24508.509829802948;24941.501169976134;25078.749212507642;25256.87371563204 12:42:26 INFO - PROCESS | 9745 | |2;jquery.html;352.931178420208;357.66558268019406;361.2449979542755;369.21541723836845;387.4459522882277;15428.537143885687;16415.34338626455;17145.399911003118;17279.30882764691;17320.826791732077;15042.84957150428;15108.093514389117;15276;15430.61124498795;15486.148261845594;4330.480342358914;4577.56513131252;4596.034832685124;4623.468301145361;4675.766211689419;3364.8822291219813;3516.507688923553;4533.070720502289;4565.269556870901;4985.451600323961;5223.268742376071;5348.224507446418;5352;5359.383670877841;5364.758585863626;5348.91976620351;5349.8127565535215;5633.690147041911;5872.823815285548;5891.322497912709;5181.4300426953005;5192.844969337721;5193.68837869729;5198.376194856603;5204.505571970657;11857.423250378268;16545.50363489097;19886;20073.397798066082;20250.189992400286;1753.2723919573361;1874.428299368692;1900.3633782682818;2032.654448743717;2332.265336419023;8572.785680357978;8573.614187361583;8804.603792829337;8810.779730506725;8835.514046727427;1574.9055056696634;1642.1214650162226;1646.983530164695;1649.9257533411026;1670.2984746406416;66347;68856;70122;71193.64403178054;71626;9502.524873756285;9633.951830240803;9654.22766178704;9718.659846905466;9732.172765315028;12829.422675979604;13010.934945325213;13082.607521774362;13092.803607945889;13094.607161785161;6938.132733408324;6987.1266091738535;7055.329743674342;7164.176119746192;7222.674979625929;6636.5354425190735;6660.6336651484635;6723.462123030145;6918.5502942308585;6927.7228910843005;4101.302778527657;4161.8959526012095;4164.937525937114;4188.455500784939;4272.252355837716;1652.7355623100245;1741.7387391891064;1772.397384889118;1784.7858257009243;1824.3364687556316;748.9851251554065;790.5651891459789;791.7767049907906;881.2553392383426;941.087145468894;15938.362465501483;16448.588785280463;16510.917445412935;16681.332746690237;16894.49316520506;805.4442434720141;829.7261903571807;831.5675848558836;865.9004214515286;866.2939704141231;9068.773280668036;9443.102905223992;9474.621015159317;9536.141747242782;9696.563654635558;371329;385177;385510;388319;390741;71265.64367178235;72858.63570682218;73386;74330;77372.61313693508;807.6607824713634;849.7408290471466;863.5941107679381;869.7390782765145;873.3188113271658;13906.235157066458;14422.206778626856;14502.564923052325;14981.625459363604;15365.846341536442;33438;33578.328433431685;34284;34459.4831077529;34463.310733785685;46146.307805382276;46836.7658161707;52788.47211527989;53556.73221633867;55224.44775552193;4806.8798280043275;6385.786700526885;7520.247975202436;7624.656890440055;10601.78079520834;11514.596989105341;11953.282803031845;12138.453769580567;12144.514219431123;12919.935400322938;4218.7468751874985;4930.211166213388;7355.374793142429;7627.313541781266;10528.631497897537;7243.818904527429;7639.503432276884;7644.388448924184;7667;7706.07527096752;7677;7694.806330549975;7933.682652693828;7956.602169891598;8130.83738325242;11313;11510.62676263006;11723.589674361356;11762.588309409472;11923.523059077539;10894.564217431214;11015.779684406427;11036.724081898017;11372.943135284271;11389.259698119928 12:42:26 INFO - PROCESS | 9745 | |3;mootools.html;1317.1372750848197;1357.0839683213828;1365.180891465121;1596.8562829345356;1628.9185540722967;6308.905366419507;6543.47652187825;7043.894341584881;7657.195994420582;7690.769276921701;7059.717611295542;7374.446916481272;7418.591977441239;7445.292697193771;7450.739224127156;2064.463239557718;2108.894555272238;2121.501447159924;2127.6914847347125;2129.6486079796814;2084.1871670048695;2108.546662467569;2119.3218170185546;2121.7984291492285;2126.0539060118253;2104.3476522278065;2111.461577297787;2115.132795553823;2130.2437634639714;2131.328631481086;2034.2371610646007;2053.712480252766;2056.897155142237;2057.362217712514;2057.609054279682;2014.1540552967788;2023.7369142011444;2032.867863588862;2038.0930485933766;2044.7648520420043;7196.892046619305;7253.310935461175;7396.926030739677;7500.474966752329;7509.173990861001;4305.311150215982;4432.689711720181;4444.555544445562;4445.955540444586;4446.355278484634;2736.87684054218;2779.166250124975;2814.8311101333984;2860.427914417104;2865.6704478984975;901.5987885391004;907.4509921497531;925.8703781470599;936.4007035497287;951.1819834941945;9877;10057.044580764743;10082.89917100827;10095.14191293741;10113.646022389255;3842.6733727632904;3902.8144239226126;4030.6775457963295;4047.1298670785923;4071.3689378146437;8723.996740374938;8724.214820666171;8739.257163141077;8753.956230218935;8808.20726134651;4313.288307429302;4352.434183556117;4368.803403846835;4380.233459144637;4484.327350897392;3497.755157138976;3614.7288953328607;3953.426753120839;4028.617281358266;4031.173609410064;3554.5023696682483;3609.4766258892837;3685.6130106338446;3700.3524383232825;3739.1773809761808;1145.5303325636448;1172.0857730969858;1185.140772939612;1222.7065504279087;1223.3638507975802;779.672537534237;780.8321210939675;785.4109417936547;815.9061707903667;820.2986446588201;4728.95271047292;4730.645201609893;4854.538818812207;4878.707277563358;5032.496750325012;359.90462527430253;361.45600870689447;365.12552436913444;367.9889603311851;369.46058754219143;3212.2772376215166;3315.469524876008;3334.449815780369;3375.578052743407;3378.35811195872;8839.204471597586;9233.353665243369;9277.304202184863;9295.628174872929;9319.673811416567;9236.168744813;9253.49105799174;9262.120098590623;9273;9290.303227257982;7104.573725576379;7191.101112360955;7227.710891564278;7238.457115716343;7244.348008679139;4666.580007799314;4814.711117332971;4830.830920917751;4868.14807408695;4981.277714731271;8390.790230244293;8445.408821382443;8500.829983400421;8600.741977740678;8646.82706345882;8573.785655358666;8668.176523230282;8700.303975682056;8711.04001599635;8766.517841518778;5448.56411487088;5623.8875222496135;6423.646699431576;6452.225732911893;6484.1894763154605;6829.214640316229;7040.647967601702;7063.929360706327;7252.166000909963;7264.091988501437;6137.508999279958;6279.96860015697;6379.011253255753;6479.31967143462;6566.9014964774615;5824.271966004249;5826.883462330815;5856.502197313106;5912;5993;5546.084895992116;5649.4633009864;5657.943420565742;5658.292713410824;5680.715964201856;4057.695672824609;4113.218488487178;4209.34755112958;4269.786510674392;4380.299152135643;4043.575424580494;4150.813213405464;4190;4243.618074373321;4298.871033868989 12:42:26 INFO - PROCESS | 9745 | |4;prototype.html;272.41702756101944;276.46779948598953;279.9888004479821;281.23083366991284;284.7622235433412;4815.808806992819;4887.364642596466;5001.749912504374;5052.924206136906;5068.72122033288;4823.517648235174;4912.606991440685;4917.434495033072;4934.901301973959;4973.214999600226;3860.4402361657544;3872.1674839909415;3882.378819388898;3886.6113388661047;3901.5708272090046;3782.300274449222;3799.35410980134;3881.20435310762;3881.9029524261978;3884.864029758959;3825.598312177223;3860.652541271285;3863.690904727629;3866.2460820140086;3879.243547508237;3827.980860095696;3836.5971572984713;3845.7884816335372;3859.26673931952;3881.844726210948;3105.8291793951325;3221.935561288761;3239.7408207343356;3398.8640454381793;3405.7105146062368;4883.118959813692;4893.853184404438;4894;4895.4125504939275;4902.730349830758;4287.142571485715;4316.892077698083;4317.9136417271475;4320.200762858881;4328.2209202343565;5014.398272207359;5164.870878228036;5177.57616655419;5189.714565698885;5202.245674377232;3521.683048525645;3530.188056746937;3533.8939831805087;3535.9469607955903;3542.5829668132696;5432.429594892519;5443.319585051869;5450.482204190595;5462.2079798429;5469.15228139639;3595.748297619194;3596.3706351388923;3598.3702852000797;3604.9279014419567;3610.6930910872343;3557.7509574329547;3588.1926566522325;3624.2389098289655;3665.865684839477;3678.779273243614;4266.658667306608;4267.317229243306;4274.10243848789;4274.5939135782055;4289.721168124062;5116.590672746172;5140.768665410065;5174.974125129425;5218.921716174261;5238;1177.8763229860913;1206.7027944959204;1236.1779416687802;1244.0296568676447;1300;787.4763282417128;813.6826637611337;828.9668413263522;838.6268110690806;838.7693384319361;4003.2193722223888;4031.899202519902;4032.8991775205855;4038.2327357801923;4047.2917239483563;4705.670603057822;4709.139889743532;4710.52894710533;4714.622830173578;4721.386219791405;4037.2934736421007;4060.7563546187325;4096.426500289962;4097.7541347518645;4101.5488296287385;2420.9273721788372;2501.8741566294875;2523.8864251108744;2525.19448594256;2543.7456254374415;4379.605835474823;4397.802098905557;4398.208322501981;4401.383806267125;4421.602055814992;4745.694933893138;4754.833580824655;4758.809647614056;4774.474807771142;4795.736234507066;4099.011979190091;4404.581564751344;4419.624331931757;4432.534583868712;4434.800433980414;4721.976390118028;4726.7636618169645;4730.7871145797835;4743.501932297059;4746.477887432448;4653.255479123324;4657.439757681214;4657.836975705834;4664.626829853536;4676.345311656439;4427.959429534121;4462.977685111554;4464.642828573771;4732.503087175797;5083.949160508348;3715;3741.7567858089137;3756.1924186300075;3756.868509602151;3760.680342170946;5434.375046869661;5437.564994800327;5445.754941027584;5447;5454.236406903116;5051.545360917535;5113;5172.250023746611;5206.713630750345;5267.947320526746;5251.737413129405;5314.4951229633125;5318.7340632967425;5328.387235467816;5334.333208348957;4976.900461990667;5207.1668533034535;5233.764480598306;5255.684658920324;5265.4997775211295;5269.578433725216;5311.3891902431715;5313;5351.759170837399;5359.517643412111;5227.686338819683;5236;5236.298203084089;5236.700878446554;5244.213367994831 12:42:26 INFO - PROCESS | 9745 | |5;yui.html;592.3414439569206;611.2176414189838;720.9783706488804;734.042075092005;742.3986570877593;12446.190997585161;12774.16967897086;12907.419166137523;13245.8013129803;13374.66563335917;12043.578474753385;12227.14409991301;12241.877581224186;12257.08071894607;12288.692782680437;627.9120923070751;743.4275607782018;761.5050217358706;762.7025460070577;763.1338430880962;642.251776680167;734.9044624198873;740.1229542991572;741.1365758890886;755.1391413788285;790.2768966395741;792.469045739356;792.6908505682788;792.8771040488733;793.3573805217763;785.8231897823001;786.2373497707215;787.2521104950263;788.7081779741475;789.6170357376697;578.095280885413;579.4408395897979;580.7183515994739;581.9272590926134;583.565243893298;12234.204776689487;12254.264744115382;12275.079369047357;12299.139060265785;12322.322272275022;12252.326122063283;12638.620841374774;12843.29361885096;12851.550195743104;13140.802887956688;10558.788824223473;10585.047345738843;10613.681589552325;10819.67540973772;10939.56241750329;3044.558539011853;3072.2472994116583;3081.6456107547697;3136.106209730216;3154.763392745553;63268.36731632671;63549.68225158891;64013.03980440344;64329;64675.67662161659;10636.639409781628;10712.143028557697;10769.9461502692;10784.838227426595;10897.346159230472;20212.191512339636;20226.39320820378;20235.797642023685;20387.694184587242;20439.795602044087;6737.8652426951185;6738.124043874265;6780.288069752703;6841.657917104125;7220.638968051577;3592.4790905319105;3595.5146055282726;3630.0743310455664;3689.1330537323706;3723.851045958131;2826.773858091348;2902.4630443368046;2931.3844092740337;2936.0898121582377;2943.9705602943695;486.406583967559;488.5163687948905;490.1936314762196;490.58300444621784;494.78971437139074;585.6076428792719;601.6420229963165;609.0346800321452;610.5237914426755;617.3548641669466;8025.3980951428875;8220.260176584135;8306.8338633227;8391;8563.357748168912;580.2833500626723;605.5246631394423;621.8911690454153;634.1629049654504;646.7736292297752;3848.5958974307855;3885.825137868803;3931.4495970564144;3937;3988.3419235826345;93288.53355733179;93972;94684;97399.51300243453;97888.51055744676;86126.56936715277;86837.13162868291;86901.56549217213;87230.56384718162;87795.56102219448;46447;73409.6329518349;73679.63160184165;74133.25866741371;75478.62260688661;7398.593077380796;7461.664225109775;7510.023696919584;7607.657655405631;7741.380689544935;32196.678033220305;41132.38301425541;44060;45068.32397514106;45745.31382029206;36012.63987360198;37025.814870925475;37475.25049499049;54246;56235.71882140563;10438.68683939483;10645.946770266099;10897.618583349862;10939.906009399314;11742.765144697229;12712.491500339884;13115.672108197372;13148.934255328662;13313.334333283103;13679.86320136786;12247.203931744409;12574.685632859251;12737.93631031839;12974.870251297743;13274.867251327363;12194.146409751233;12432.564860229848;12439.626811195678;13135;13379.665508362368;10670.57317707283;11134.721631959266;11311.321320720454;12360.381980901098;12445.875541244472;8890.555472226491;9006.594703238501;9153.405028673114;9224.35429519954;10001.249906257206;10127.64553240633;10403;10457.111145552713;10524.263301568817;10604.734881628021 12:42:26 INFO - PROCESS | 9745 | __end_tp_report 12:42:26 INFO - PROCESS | 9745 | __start_cc_report 12:42:26 INFO - PROCESS | 9745 | _x_x_mozilla_cycle_collect,341 12:42:26 INFO - PROCESS | 9745 | __end_cc_report 12:42:26 INFO - PROCESS | 9745 | __startTimestamp1475178146215__endTimestamp 12:42:26 INFO - PROCESS | 9745 | 12:42:26 INFO - PROCESS | 9745 | ------- Summary: start ------- 12:42:26 INFO - PROCESS | 9745 | Number of tests: 6 12:42:26 INFO - PROCESS | 9745 | 12:42:26 INFO - PROCESS | 9745 | [#0] dojo.html Cycles:165 Average:4709.35 Median:4822.73 stddev:508.08 (10.5%) stddev-sans-first:481.49 12:42:26 INFO - PROCESS | 9745 | Values: 2583.4 2598.0 2608.2 2625.4 2652.5 4592.0 4755.5 4773.9 4782.3 4804.0 4664.7 4709.8 4783.5 4803.2 4821.8 4281.7 4311.9 4342.8 4402.4 4441.6 4461.1 4490.5 4501.1 4502.0 4511.5 4208.2 4234.9 4328.8 4357.7 4368.5 4394.2 4399.3 4445.2 4453.5 4454.5 4337.5 4356.8 4365.9 4384.7 4415.4 4591.2 4634.3 4698.4 4755.3 4837.4 5088.9 5090.2 5098.7 5149.3 5165.6 5124.8 5135.3 5135.5 5135.8 5194.3 4580.7 4631.5 4766.8 4779.5 4779.9 5164.1 5232.8 5236.1 5238.3 5294.5 5016.8 5017.7 5029.7 5034.1 5081.9 4873.9 4942.7 4949.0 5104.2 5118.5 5041.5 5104.3 5112.3 5126.3 5192.2 5070.3 5091.1 5102.1 5103.4 5165.4 4171.5 4342.8 4357.9 4366.8 4402.0 3651.9 3733.8 3749.4 3766.1 3769.3 4349.2 4406.0 4422.6 4455.2 4457.8 5137.1 5149.4 5149.6 5154.6 5217.0 4207.1 4261.5 4392.4 4401.4 4459.8 4598.4 4622.5 4645.3 4654.0 4709.1 4822.7 4829.3 4834.2 4845.9 4863.8 4938.9 5173.1 5184.9 5191.1 5240.5 4656.7 4720.6 4743.3 4772.7 4844.5 5013.8 5020.0 5029.1 5030.9 5097.1 5066.7 5115.6 5120.4 5121.1 5124.4 4773.1 4822.0 4832.4 4893.9 4923.7 4925.2 4953.5 4960.0 4998.8 5010.8 4706.0 4733.1 4837.7 4860.8 4917.2 5022.1 5051.2 5051.3 5055.5 5134.4 4958.9 4964.7 4968.1 4970.5 5029.6 12:42:26 INFO - PROCESS | 9745 | 12:42:26 INFO - PROCESS | 9745 | [#1] ext.html Cycles:180 Average:40742.81 Median:35200.74 stddev:72269.54 (205.3%) stddev-sans-first:72409.25 12:42:26 INFO - PROCESS | 9745 | Values: 542.8 549.0 550.5 558.4 561.1 36442.5 37772.4 37838.8 37931.4 37967.4 39412.0 39991.0 40223.4 40261.8 40372.0 7679.8 7857.1 7868.7 7872.4 7878.2 7763.4 7785.3 7865.4 7865.5 7882.9 7853.2 7887.9 7889.2 7894.2 7906.1 7719.9 7847.5 7874.3 7899.2 7902.8 7669.7 7685.4 7701.5 7714.4 7741.1 36745.1 37008.0 37018.8 37297.6 37357.6 2919.8 3055.7 3262.6 3622.9 3730.2 27284.2 27501.2 27524.6 27710.3 28577.4 3496.2 3536.6 3540.2 3581.8 3582.4 166345.0 166832.0 167029.0 167335.0 167342.0 30468.2 31424.2 50021.2 50274.0 50383.0 32550.8 32666.5 32698.8 32873.7 32897.0 12508.2 12706.7 12742.0 12743.2 12747.1 10403.5 10423.2 10432.6 10435.3 10466.9 7700.0 7714.0 7785.4 7821.3 7831.8 3035.1 3044.1 3067.4 3083.7 3106.2 816.8 838.4 866.8 889.8 1005.6 25832.4 27644.6 27778.3 28021.7 28269.0 893.2 898.7 936.8 940.5 1035.0 13893.2 14668.3 14959.3 15032.0 15121.3 368544.0 368886.0 369049.0 369184.0 370633.0 48563.8 48816.3 48957.8 49039.0 49116.8 1106.2 1138.7 1170.4 1171.1 1177.2 26414.7 27167.3 27180.6 27935.6 27952.4 41470.0 41743.6 41829.8 41843.2 42037.2 245132.0 245563.0 246019.0 246098.0 247102.0 24367.0 24833.4 24874.0 24895.3 24956.8 40064.8 40904.0 41373.2 41654.4 42079.0 34797.7 35038.6 35095.6 35194.8 35243.0 34443.7 34685.7 34794.5 34948.0 35206.6 24787.5 28265.7 32586.7 33027.8 34977.1 29449.7 31563.7 32405.4 32464.8 32510.8 24277.4 24508.5 24941.5 25078.7 25256.9 12:42:26 INFO - PROCESS | 9745 | 12:42:26 INFO - PROCESS | 9745 | [#2] jquery.html Cycles:180 Average:23616.60 Median:25384.89 stddev:63488.72 (250.1%) stddev-sans-first:63642.79 12:42:26 INFO - PROCESS | 9745 | Values: 352.9 357.7 361.2 369.2 387.4 15428.5 16415.3 17145.4 17279.3 17320.8 15042.8 15108.1 15276.0 15430.6 15486.1 4330.5 4577.6 4596.0 4623.5 4675.8 3364.9 3516.5 4533.1 4565.3 4985.5 5223.3 5348.2 5352.0 5359.4 5364.8 5348.9 5349.8 5633.7 5872.8 5891.3 5181.4 5192.8 5193.7 5198.4 5204.5 11857.4 16545.5 19886.0 20073.4 20250.2 1753.3 1874.4 1900.4 2032.7 2332.3 8572.8 8573.6 8804.6 8810.8 8835.5 1574.9 1642.1 1647.0 1649.9 1670.3 66347.0 68856.0 70122.0 71193.6 71626.0 9502.5 9634.0 9654.2 9718.7 9732.2 12829.4 13010.9 13082.6 13092.8 13094.6 6938.1 6987.1 7055.3 7164.2 7222.7 6636.5 6660.6 6723.5 6918.6 6927.7 4101.3 4161.9 4164.9 4188.5 4272.3 1652.7 1741.7 1772.4 1784.8 1824.3 749.0 790.6 791.8 881.3 941.1 15938.4 16448.6 16510.9 16681.3 16894.5 805.4 829.7 831.6 865.9 866.3 9068.8 9443.1 9474.6 9536.1 9696.6 371329.0 385177.0 385510.0 388319.0 390741.0 71265.6 72858.6 73386.0 74330.0 77372.6 807.7 849.7 863.6 869.7 873.3 13906.2 14422.2 14502.6 14981.6 15365.8 33438.0 33578.3 34284.0 34459.5 34463.3 46146.3 46836.8 52788.5 53556.7 55224.4 4806.9 6385.8 7520.2 7624.7 10601.8 11514.6 11953.3 12138.5 12144.5 12919.9 4218.7 4930.2 7355.4 7627.3 10528.6 7243.8 7639.5 7644.4 7667.0 7706.1 7677.0 7694.8 7933.7 7956.6 8130.8 11313.0 11510.6 11723.6 11762.6 11923.5 10894.6 11015.8 11036.7 11372.9 11389.3 12:42:26 INFO - PROCESS | 9745 | 12:42:26 INFO - PROCESS | 9745 | [#3] mootools.html Cycles:180 Average:4836.15 Median:4729.80 stddev:2741.74 (58.0%) stddev-sans-first:2736.68 12:42:26 INFO - PROCESS | 9745 | Values: 1317.1 1357.1 1365.2 1596.9 1628.9 6308.9 6543.5 7043.9 7657.2 7690.8 7059.7 7374.4 7418.6 7445.3 7450.7 2064.5 2108.9 2121.5 2127.7 2129.6 2084.2 2108.5 2119.3 2121.8 2126.1 2104.3 2111.5 2115.1 2130.2 2131.3 2034.2 2053.7 2056.9 2057.4 2057.6 2014.2 2023.7 2032.9 2038.1 2044.8 7196.9 7253.3 7396.9 7500.5 7509.2 4305.3 4432.7 4444.6 4446.0 4446.4 2736.9 2779.2 2814.8 2860.4 2865.7 901.6 907.5 925.9 936.4 951.2 9877.0 10057.0 10082.9 10095.1 10113.6 3842.7 3902.8 4030.7 4047.1 4071.4 8724.0 8724.2 8739.3 8754.0 8808.2 4313.3 4352.4 4368.8 4380.2 4484.3 3497.8 3614.7 3953.4 4028.6 4031.2 3554.5 3609.5 3685.6 3700.4 3739.2 1145.5 1172.1 1185.1 1222.7 1223.4 779.7 780.8 785.4 815.9 820.3 4729.0 4730.6 4854.5 4878.7 5032.5 359.9 361.5 365.1 368.0 369.5 3212.3 3315.5 3334.4 3375.6 3378.4 8839.2 9233.4 9277.3 9295.6 9319.7 9236.2 9253.5 9262.1 9273.0 9290.3 7104.6 7191.1 7227.7 7238.5 7244.3 4666.6 4814.7 4830.8 4868.1 4981.3 8390.8 8445.4 8500.8 8600.7 8646.8 8573.8 8668.2 8700.3 8711.0 8766.5 5448.6 5623.9 6423.6 6452.2 6484.2 6829.2 7040.6 7063.9 7252.2 7264.1 6137.5 6280.0 6379.0 6479.3 6566.9 5824.3 5826.9 5856.5 5912.0 5993.0 5546.1 5649.5 5657.9 5658.3 5680.7 4057.7 4113.2 4209.3 4269.8 4380.3 4043.6 4150.8 4190.0 4243.6 4298.9 12:42:26 INFO - PROCESS | 9745 | 12:42:26 INFO - PROCESS | 9745 | [#4] prototype.html Cycles:180 Average:4145.15 Median:4448.89 stddev:1234.69 (27.8%) stddev-sans-first:1203.45 12:42:26 INFO - PROCESS | 9745 | Values: 272.4 276.5 280.0 281.2 284.8 4815.8 4887.4 5001.7 5052.9 5068.7 4823.5 4912.6 4917.4 4934.9 4973.2 3860.4 3872.2 3882.4 3886.6 3901.6 3782.3 3799.4 3881.2 3881.9 3884.9 3825.6 3860.7 3863.7 3866.2 3879.2 3828.0 3836.6 3845.8 3859.3 3881.8 3105.8 3221.9 3239.7 3398.9 3405.7 4883.1 4893.9 4894.0 4895.4 4902.7 4287.1 4316.9 4317.9 4320.2 4328.2 5014.4 5164.9 5177.6 5189.7 5202.2 3521.7 3530.2 3533.9 3535.9 3542.6 5432.4 5443.3 5450.5 5462.2 5469.2 3595.7 3596.4 3598.4 3604.9 3610.7 3557.8 3588.2 3624.2 3665.9 3678.8 4266.7 4267.3 4274.1 4274.6 4289.7 5116.6 5140.8 5175.0 5218.9 5238.0 1177.9 1206.7 1236.2 1244.0 1300.0 787.5 813.7 829.0 838.6 838.8 4003.2 4031.9 4032.9 4038.2 4047.3 4705.7 4709.1 4710.5 4714.6 4721.4 4037.3 4060.8 4096.4 4097.8 4101.5 2420.9 2501.9 2523.9 2525.2 2543.7 4379.6 4397.8 4398.2 4401.4 4421.6 4745.7 4754.8 4758.8 4774.5 4795.7 4099.0 4404.6 4419.6 4432.5 4434.8 4722.0 4726.8 4730.8 4743.5 4746.5 4653.3 4657.4 4657.8 4664.6 4676.3 4428.0 4463.0 4464.6 4732.5 5083.9 3715.0 3741.8 3756.2 3756.9 3760.7 5434.4 5437.6 5445.8 5447.0 5454.2 5051.5 5113.0 5172.3 5206.7 5267.9 5251.7 5314.5 5318.7 5328.4 5334.3 4976.9 5207.2 5233.8 5255.7 5265.5 5269.6 5311.4 5313.0 5351.8 5359.5 5227.7 5236.0 5236.3 5236.7 5244.2 12:42:26 INFO - PROCESS | 9745 | 12:42:26 INFO - PROCESS | 9745 | [#5] yui.html Cycles:180 Average:17110.12 Median:42596.19 stddev:24394.36 (57.3%) stddev-sans-first:24431.26 12:42:26 INFO - PROCESS | 9745 | Values: 592.3 611.2 721.0 734.0 742.4 12446.2 12774.2 12907.4 13245.8 13374.7 12043.6 12227.1 12241.9 12257.1 12288.7 627.9 743.4 761.5 762.7 763.1 642.3 734.9 740.1 741.1 755.1 790.3 792.5 792.7 792.9 793.4 785.8 786.2 787.3 788.7 789.6 578.1 579.4 580.7 581.9 583.6 12234.2 12254.3 12275.1 12299.1 12322.3 12252.3 12638.6 12843.3 12851.6 13140.8 10558.8 10585.0 10613.7 10819.7 10939.6 3044.6 3072.2 3081.6 3136.1 3154.8 63268.4 63549.7 64013.0 64329.0 64675.7 10636.6 10712.1 10769.9 10784.8 10897.3 20212.2 20226.4 20235.8 20387.7 20439.8 6737.9 6738.1 6780.3 6841.7 7220.6 3592.5 3595.5 3630.1 3689.1 3723.9 2826.8 2902.5 2931.4 2936.1 2944.0 486.4 488.5 490.2 490.6 494.8 585.6 601.6 609.0 610.5 617.4 8025.4 8220.3 8306.8 8391.0 8563.4 580.3 605.5 621.9 634.2 646.8 3848.6 3885.8 3931.4 3937.0 3988.3 93288.5 93972.0 94684.0 97399.5 97888.5 86126.6 86837.1 86901.6 87230.6 87795.6 46447.0 73409.6 73679.6 74133.3 75478.6 7398.6 7461.7 7510.0 7607.7 7741.4 32196.7 41132.4 44060.0 45068.3 45745.3 36012.6 37025.8 37475.3 54246.0 56235.7 10438.7 10645.9 10897.6 10939.9 11742.8 12712.5 13115.7 13148.9 13313.3 13679.9 12247.2 12574.7 12737.9 12974.9 13274.9 12194.1 12432.6 12439.6 13135.0 13379.7 10670.6 11134.7 11311.3 12360.4 12445.9 8890.6 9006.6 9153.4 9224.4 10001.2 10127.6 10403.0 10457.1 10524.3 10604.7 12:42:26 INFO - PROCESS | 9745 | -------- Summary: end -------- 12:42:26 INFO - PROCESS | 9745 | 12:42:27 INFO - TEST-INFO | 9745: exit 0 12:42:27 INFO - TEST-OK | dromaeo_css | took 1118331ms 12:42:27 INFO - TEST-START | kraken 12:42:27 INFO - operating with platform_type : linux_ 12:42:27 INFO - Initialising browser for kraken test... 12:42:27 INFO - TEST-INFO | started process 10103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeD_kMm/profile http://localhost:38352/getInfo.html) 12:42:32 INFO - PROCESS | 10103 | __metrics Screen width/height:1600/1200 12:42:32 INFO - PROCESS | 10103 | colorDepth:24 12:42:32 INFO - PROCESS | 10103 | Browser inner width/height: 1024/697 12:42:32 INFO - PROCESS | 10103 | __metrics 12:42:32 ERROR - PROCESS | 10103 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 12:42:33 INFO - TEST-INFO | 10103: exit 0 12:42:33 INFO - Browser initialized. 12:42:33 INFO - Running cycle 1/1 for kraken test... 12:42:33 INFO - TEST-INFO | started process 10223 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeD_kMm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:42:46 INFO - PROCESS | 10223 | RSS: Main: 186114048 12:42:46 INFO - PROCESS | 10223 | 12:42:49 INFO - PROCESS | 10223 | Cycle 1(1): loaded http://localhost:38352/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38352/tests/kraken/driver.html?testName=audio-beat-detection) 12:42:50 INFO - PROCESS | 10223 | RSS: Main: 200081408 12:42:50 INFO - PROCESS | 10223 | 12:42:52 INFO - PROCESS | 10223 | Cycle 1(1): loaded http://localhost:38352/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38352/tests/kraken/driver.html?testName=audio-dft) 12:42:53 INFO - PROCESS | 10223 | RSS: Main: 198152192 12:42:53 INFO - PROCESS | 10223 | 12:42:56 INFO - PROCESS | 10223 | Cycle 1(1): loaded http://localhost:38352/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38352/tests/kraken/driver.html?testName=audio-fft) 12:42:57 INFO - PROCESS | 10223 | RSS: Main: 193552384 12:42:57 INFO - PROCESS | 10223 | 12:42:59 INFO - PROCESS | 10223 | Cycle 1(1): loaded http://localhost:38352/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38352/tests/kraken/driver.html?testName=audio-oscillator) 12:42:59 INFO - PROCESS | 10223 | RSS: Main: 193814528 12:42:59 INFO - PROCESS | 10223 | 12:43:02 INFO - PROCESS | 10223 | Cycle 1(1): loaded http://localhost:38352/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38352/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:43:02 INFO - PROCESS | 10223 | RSS: Main: 194277376 12:43:02 INFO - PROCESS | 10223 | 12:43:05 INFO - PROCESS | 10223 | Cycle 1(1): loaded http://localhost:38352/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38352/tests/kraken/driver.html?testName=imaging-darkroom) 12:43:06 INFO - PROCESS | 10223 | RSS: Main: 194129920 12:43:06 INFO - PROCESS | 10223 | 12:43:10 INFO - PROCESS | 10223 | Cycle 1(1): loaded http://localhost:38352/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38352/tests/kraken/driver.html?testName=imaging-desaturate) 12:43:10 INFO - PROCESS | 10223 | RSS: Main: 192139264 12:43:10 INFO - PROCESS | 10223 | 12:43:13 INFO - PROCESS | 10223 | Cycle 1(1): loaded http://localhost:38352/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38352/tests/kraken/driver.html?testName=json-parse-financial) 12:43:14 INFO - PROCESS | 10223 | RSS: Main: 193748992 12:43:14 INFO - PROCESS | 10223 | 12:43:15 INFO - PROCESS | 10223 | Cycle 1(1): loaded http://localhost:38352/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38352/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:43:16 INFO - PROCESS | 10223 | RSS: Main: 193855488 12:43:16 INFO - PROCESS | 10223 | 12:43:18 INFO - PROCESS | 10223 | Cycle 1(1): loaded http://localhost:38352/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38352/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:43:19 INFO - PROCESS | 10223 | RSS: Main: 194064384 12:43:19 INFO - PROCESS | 10223 | 12:43:21 INFO - PROCESS | 10223 | Cycle 1(1): loaded http://localhost:38352/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38352/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:43:22 INFO - PROCESS | 10223 | RSS: Main: 194277376 12:43:22 INFO - PROCESS | 10223 | 12:43:24 INFO - PROCESS | 10223 | Cycle 1(1): loaded http://localhost:38352/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38352/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:43:25 INFO - PROCESS | 10223 | RSS: Main: 194539520 12:43:25 INFO - PROCESS | 10223 | 12:43:28 INFO - PROCESS | 10223 | Cycle 1(1): loaded http://localhost:38352/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38352/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:43:29 INFO - PROCESS | 10223 | RSS: Main: 194408448 12:43:29 INFO - PROCESS | 10223 | 12:43:30 INFO - PROCESS | 10223 | Cycle 1(1): loaded http://localhost:38352/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38352/tests/kraken/driver.html?testName=ai-astar) 12:43:31 INFO - PROCESS | 10223 | RSS: Main: 197124096 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | __start_tp_report 12:43:31 INFO - PROCESS | 10223 | _x_x_mozilla_page_load 12:43:31 INFO - PROCESS | 10223 | _x_x_mozilla_page_load_details 12:43:31 INFO - PROCESS | 10223 | |i|pagename|runs| 12:43:31 INFO - PROCESS | 10223 | |0;ai-astar;106;116;116;118;116;116;117;118;115;117 12:43:31 INFO - PROCESS | 10223 | |1;audio-beat-detection;158;127;131;179;132;126;131;131;174;125 12:43:31 INFO - PROCESS | 10223 | |2;audio-dft;170;169;164;164;164;164;162;165;164;164 12:43:31 INFO - PROCESS | 10223 | |3;audio-fft;76;75;77;118;79;80;78;79;103;76 12:43:31 INFO - PROCESS | 10223 | |4;audio-oscillator;85;84;110;86;83;84;102;83;83;121 12:43:31 INFO - PROCESS | 10223 | |5;imaging-gaussian-blur;117;117;118;119;118;118;118;119;118;117 12:43:31 INFO - PROCESS | 10223 | |6;imaging-darkroom;148;148;147;148;147;147;148;148;151;147 12:43:31 INFO - PROCESS | 10223 | |7;imaging-desaturate;96;96;97;96;96;95;97;97;97;96 12:43:31 INFO - PROCESS | 10223 | |8;json-parse-financial;64;63;64;65;66;65;66;65;64;65 12:43:31 INFO - PROCESS | 10223 | |9;json-stringify-tinderbox;67;67;67;66;68;69;67;67;66;65 12:43:31 INFO - PROCESS | 10223 | |10;stanford-crypto-aes;87;86;86;87;83;87;88;84;83;84 12:43:31 INFO - PROCESS | 10223 | |11;stanford-crypto-ccm;149;137;134;133;150;147;150;139;176;137 12:43:31 INFO - PROCESS | 10223 | |12;stanford-crypto-pbkdf2;180;179;178;175;174;175;174;172;173;174 12:43:31 INFO - PROCESS | 10223 | |13;stanford-crypto-sha256-iterative;71;71;71;69;70;71;72;74;71;70 12:43:31 INFO - PROCESS | 10223 | __end_tp_report 12:43:31 INFO - PROCESS | 10223 | __start_cc_report 12:43:31 INFO - PROCESS | 10223 | _x_x_mozilla_cycle_collect,818 12:43:31 INFO - PROCESS | 10223 | __end_cc_report 12:43:31 INFO - PROCESS | 10223 | __startTimestamp1475178211233__endTimestamp 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | ------- Summary: start ------- 12:43:31 INFO - PROCESS | 10223 | Number of tests: 14 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.50 stddev:3.47 (3.0%) stddev-sans-first:1.01 12:43:31 INFO - PROCESS | 10223 | Values: 106.0 116.0 116.0 118.0 116.0 116.0 117.0 118.0 115.0 117.0 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:131.50 stddev:20.76 (15.8%) stddev-sans-first:21.13 12:43:31 INFO - PROCESS | 10223 | Values: 158.0 127.0 131.0 179.0 132.0 126.0 131.0 131.0 174.0 125.0 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:2.49 (1.5%) stddev-sans-first:1.88 12:43:31 INFO - PROCESS | 10223 | Values: 170.0 169.0 164.0 164.0 164.0 164.0 162.0 165.0 164.0 164.0 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | [#3] audio-fft Cycles:10 Average:84.10 Median:77.50 stddev:14.44 (18.6%) stddev-sans-first:15.02 12:43:31 INFO - PROCESS | 10223 | Values: 76.0 75.0 77.0 118.0 79.0 80.0 78.0 79.0 103.0 76.0 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:83.50 stddev:13.83 (16.6%) stddev-sans-first:14.43 12:43:31 INFO - PROCESS | 10223 | Values: 85.0 84.0 110.0 86.0 83.0 84.0 102.0 83.0 83.0 121.0 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 12:43:31 INFO - PROCESS | 10223 | Values: 117.0 117.0 118.0 119.0 118.0 118.0 118.0 119.0 118.0 117.0 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.20 (0.8%) stddev-sans-first:1.27 12:43:31 INFO - PROCESS | 10223 | Values: 148.0 148.0 147.0 148.0 147.0 147.0 148.0 148.0 151.0 147.0 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 12:43:31 INFO - PROCESS | 10223 | Values: 96.0 96.0 97.0 96.0 96.0 95.0 97.0 97.0 97.0 96.0 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:0.95 (1.5%) stddev-sans-first:0.97 12:43:31 INFO - PROCESS | 10223 | Values: 64.0 63.0 64.0 65.0 66.0 65.0 66.0 65.0 64.0 65.0 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 12:43:31 INFO - PROCESS | 10223 | Values: 67.0 67.0 67.0 66.0 68.0 69.0 67.0 67.0 66.0 65.0 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.50 stddev:1.84 (2.1%) stddev-sans-first:1.87 12:43:31 INFO - PROCESS | 10223 | Values: 87.0 86.0 86.0 87.0 83.0 87.0 88.0 84.0 83.0 84.0 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:148.00 stddev:12.73 (8.6%) stddev-sans-first:13.43 12:43:31 INFO - PROCESS | 10223 | Values: 149.0 137.0 134.0 133.0 150.0 147.0 150.0 139.0 176.0 137.0 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.40 Median:175.00 stddev:2.67 (1.5%) stddev-sans-first:2.26 12:43:31 INFO - PROCESS | 10223 | Values: 180.0 179.0 178.0 175.0 174.0 175.0 174.0 172.0 173.0 174.0 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:1.33 (1.9%) stddev-sans-first:1.41 12:43:31 INFO - PROCESS | 10223 | Values: 71.0 71.0 71.0 69.0 70.0 71.0 72.0 74.0 71.0 70.0 12:43:31 INFO - PROCESS | 10223 | -------- Summary: end -------- 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | 12:43:31 INFO - PROCESS | 10223 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 12:43:31 INFO - PROCESS | 10223 | 12:43:32 INFO - TEST-INFO | 10223: exit 0 12:43:32 INFO - TEST-OK | kraken | took 65243ms 12:43:32 INFO - SUITE-END | took 1183s 12:43:32 INFO - Completed test suite (00:19:43) 12:43:32 INFO - javascript benchmark 12:43:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6135.160346069779, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2583.444559419725, 2598.0387256715007, 2608.243609353288, 2625.4092829113447, 2652.522545941731, 4591.966807468326, 4755.500672429397, 4773.8806529836775, 4782.306565547993, 4804.039192161565, 4664.650151238654, 4709.764511774406, 4783.545563171493, 4803.159447096761, 4821.807127714896, 4281.657467402601, 4311.913761724763, 4342.826286948518, 4402.449693788277, 4441.578050085237, 4461.063176732874, 4490.461144662629, 4501.122281155176, 4501.954980450203, 4511.52628973958, 4208.179405015992, 4234.894127646803, 4328.826846926119, 4357.651387888961, 4368.541303163154, 4394.1651086293505, 4399.296112621965, 4445.222086134946, 4453.465584129893, 4454.48773391061, 4337.479502459725, 4356.760378179199, 4365.9126817463475, 4384.693071484998, 4415.4259946206785, 4591.150637132141, 4634.281686338623, 4698.365720627706, 4755.310479980383, 4837.371141751585, 5088.898222035576, 5090.1855703087695, 5098.694078355311, 5149.30484384607, 5165.586753059746, 5124.769385377667, 5135.255387968761, 5135.486451354872, 5135.84592462223, 5194.3247377840635, 4580.65645076614, 4631.536846315342, 4766.833160839354, 4779.498152693986, 4779.928301075487, 5164.096283150434, 5232.816851410183, 5236.1098613235845, 5238.345206849144, 5294.470552944675, 5016.799328026838, 5017.7491125443585, 5029.698218106925, 5034.0938631046765, 5081.923771143436, 4873.926891096637, 4942.728149951788, 4949.034938187019, 5104.234364845229, 5118.462561431071, 5041.546260836542, 5104.3109180260935, 5112.258722485219, 5126.307948426989, 5192.247124166975, 5070.285606579175, 5091.08360495107, 5102.107131252016, 5103.413107492612, 5165.354330708661, 4171.499420069611, 4342.826286948487, 4357.9128417431475, 4366.759828209415, 4401.977990110093, 3651.8539258429896, 3733.7946412947003, 3749.3813520769313, 3766.0584853786554, 3769.3026790043928, 4349.195398851222, 4405.977970110129, 4422.579854913778, 4455.242608756519, 4457.843975460908, 5137.100673415772, 5149.356330458692, 5149.562287205555, 5154.639175257771, 5217.034848553029, 4207.053412982054, 4261.531231564525, 4392.363107349481, 4401.449818772653, 4459.777011149429, 4598.402207713043, 4622.537746225418, 4645.3032045193495, 4653.976730116327, 4709.058188362341, 4822.734749588806, 4829.275608658589, 4834.20235661126, 4845.878853028632, 4863.756812159378, 4938.851834444972, 5173.0688476074665, 5184.899769801599, 5191.143461328989, 5240.502152295526, 4656.720596764205, 4720.645951553716, 4743.335932969318, 4772.6659133861685, 4844.491328410466, 5013.774380152829, 5020.046191223656, 5029.145045342374, 5030.874228144326, 5097.057044446789, 5066.670666406671, 5115.590752739847, 5120.436751957356, 5121.103806833715, 5124.385073791169, 4773.1408346497965, 4821.975890120527, 4832.395950506187, 4893.853184404474, 4923.729194894315, 4925.21196608541, 4953.455119936732, 4960.032793605356, 4998.775055122455, 5010.849674509771, 4706.011737535019, 4733.148033354029, 4837.733924634179, 4860.76050607107, 4917.188663870421, 5022.070916880389, 5051.2423136529815, 5051.267566202807, 5055.469175736494, 5134.358205224347, 4958.851234462972, 4964.67729597575, 4968.105740966661, 4970.5029497051455, 5029.597632189343], "value": 4675.884459540673, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.7991643092055, 548.9980785067253, 550.5457997152349, 558.3801979802416, 561.1050374652428, 36442.453363199544, 37772.43341349882, 37838.810805945934, 37931.43102853453, 37967.44390673116, 39412.0, 39991.0, 40223.396649050286, 40261.7986910065, 40371.962803719616, 7679.769606911802, 7857.096433910087, 7868.724594639189, 7872.448928574973, 7878.172791856859, 7763.417743669219, 7785.260400261966, 7865.410094242926, 7865.488743231672, 7882.881756773653, 7853.214678532129, 7887.921120788805, 7889.1716369780925, 7894.2105789421175, 7906.130325664172, 7719.922800771977, 7847.489913155627, 7874.251946065115, 7899.249571290718, 7902.841943161105, 7669.6932122715025, 7685.385169186452, 7701.460897737161, 7714.382849372093, 7741.148473667892, 36745.08137296589, 37008.0, 37018.8149059253, 37297.627023729685, 37357.62642373596, 2919.8102123362128, 3055.6791536888527, 3262.5921759780026, 3622.9275414491826, 3730.1908574341423, 27284.181474555797, 27501.174964751088, 27524.58713119305, 27710.307242319104, 28577.428451431064, 3496.1609213788506, 3536.5792759051187, 3540.2211513466996, 3581.8209089545417, 3582.390993531106, 166345.0, 166832.0, 167029.0, 167335.0, 167342.0, 30468.23829404238, 31424.21439463986, 50021.24968125481, 50274.0, 50383.0, 32550.837245814095, 32666.510002349984, 32698.83650581732, 32873.67126328706, 32897.0, 12508.186967847061, 12706.745865082832, 12742.044346674036, 12743.235405875677, 12747.107702460738, 10403.491493733367, 10423.166146708245, 10432.5826966922, 10435.32170408921, 10466.947665261778, 7700.0, 7713.961430192925, 7785.3771698264, 7821.335186509211, 7831.843363132705, 3035.104644129987, 3044.0563425338214, 3067.4478593852873, 3083.691630836898, 3106.223444138965, 816.7713040348712, 838.3502785341409, 866.7951547349189, 889.7731078575051, 1005.5625802775816, 25832.354191145372, 27644.58533122005, 27778.305542361602, 28021.71978280232, 28269.0, 893.1738142218422, 898.6854600889636, 936.765808547863, 940.520334629344, 1035.0270745499206, 13893.235872027135, 14668.339924703201, 14959.252037398086, 15032.0, 15121.319540620698, 368544.0, 368886.0, 369049.0, 369184.0, 370633.0, 48563.75718121387, 48816.26775598369, 48957.75521122372, 49039.0, 49116.7544162284, 1106.2201148190507, 1138.703936976392, 1170.403094421851, 1171.0748508678048, 1177.2230327983489, 26414.735852641228, 27167.320816979733, 27180.592291116045, 27935.580966285117, 27952.38785600353, 41470.0, 41743.58256417397, 41829.79085104555, 41843.163136737705, 42037.159256814084, 245132.0, 245563.0, 246019.0, 246098.0, 247102.0, 24367.0, 24833.379165521008, 24874.0, 24895.253142405756, 24956.75043249617, 40064.799676001436, 40904.0, 41373.172536549704, 41654.37518437165, 42079.0, 34797.652023479444, 35038.64961350456, 35095.649043509235, 35194.82402587971, 35243.0, 34443.655563444045, 34685.65314346824, 34794.478082829286, 34948.0, 35206.64793352034, 24787.504249915262, 28265.71734282713, 32586.674133259312, 33027.83486082554, 34977.12557186091, 29449.705502944696, 31563.684363156994, 32405.35189296154, 32464.83767581147, 32510.837445813566, 24277.393065173514, 24508.509829802948, 24941.501169976134, 25078.749212507642, 25256.87371563204], "value": 15757.603677640192, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.931178420208, 357.66558268019406, 361.2449979542755, 369.21541723836845, 387.4459522882277, 15428.537143885687, 16415.34338626455, 17145.399911003118, 17279.30882764691, 17320.826791732077, 15042.84957150428, 15108.093514389117, 15276.0, 15430.61124498795, 15486.148261845594, 4330.480342358914, 4577.56513131252, 4596.034832685124, 4623.468301145361, 4675.766211689419, 3364.8822291219813, 3516.507688923553, 4533.070720502289, 4565.269556870901, 4985.451600323961, 5223.268742376071, 5348.224507446418, 5352.0, 5359.383670877841, 5364.758585863626, 5348.91976620351, 5349.8127565535215, 5633.690147041911, 5872.823815285548, 5891.322497912709, 5181.4300426953005, 5192.844969337721, 5193.68837869729, 5198.376194856603, 5204.505571970657, 11857.423250378268, 16545.50363489097, 19886.0, 20073.397798066082, 20250.189992400286, 1753.2723919573361, 1874.428299368692, 1900.3633782682818, 2032.654448743717, 2332.265336419023, 8572.785680357978, 8573.614187361583, 8804.603792829337, 8810.779730506725, 8835.514046727427, 1574.9055056696634, 1642.1214650162226, 1646.983530164695, 1649.9257533411026, 1670.2984746406416, 66347.0, 68856.0, 70122.0, 71193.64403178054, 71626.0, 9502.524873756285, 9633.951830240803, 9654.22766178704, 9718.659846905466, 9732.172765315028, 12829.422675979604, 13010.934945325213, 13082.607521774362, 13092.803607945889, 13094.607161785161, 6938.132733408324, 6987.1266091738535, 7055.329743674342, 7164.176119746192, 7222.674979625929, 6636.5354425190735, 6660.6336651484635, 6723.462123030145, 6918.5502942308585, 6927.7228910843005, 4101.302778527657, 4161.8959526012095, 4164.937525937114, 4188.455500784939, 4272.252355837716, 1652.7355623100245, 1741.7387391891064, 1772.397384889118, 1784.7858257009243, 1824.3364687556316, 748.9851251554065, 790.5651891459789, 791.7767049907906, 881.2553392383426, 941.087145468894, 15938.362465501483, 16448.588785280463, 16510.917445412935, 16681.332746690237, 16894.49316520506, 805.4442434720141, 829.7261903571807, 831.5675848558836, 865.9004214515286, 866.2939704141231, 9068.773280668036, 9443.102905223992, 9474.621015159317, 9536.141747242782, 9696.563654635558, 371329.0, 385177.0, 385510.0, 388319.0, 390741.0, 71265.64367178235, 72858.63570682218, 73386.0, 74330.0, 77372.61313693508, 807.6607824713634, 849.7408290471466, 863.5941107679381, 869.7390782765145, 873.3188113271658, 13906.235157066458, 14422.206778626856, 14502.564923052325, 14981.625459363604, 15365.846341536442, 33438.0, 33578.328433431685, 34284.0, 34459.4831077529, 34463.310733785685, 46146.307805382276, 46836.7658161707, 52788.47211527989, 53556.73221633867, 55224.44775552193, 4806.8798280043275, 6385.786700526885, 7520.247975202436, 7624.656890440055, 10601.78079520834, 11514.596989105341, 11953.282803031845, 12138.453769580567, 12144.514219431123, 12919.935400322938, 4218.7468751874985, 4930.211166213388, 7355.374793142429, 7627.313541781266, 10528.631497897537, 7243.818904527429, 7639.503432276884, 7644.388448924184, 7667.0, 7706.07527096752, 7677.0, 7694.806330549975, 7933.682652693828, 7956.602169891598, 8130.83738325242, 11313.0, 11510.62676263006, 11723.589674361356, 11762.588309409472, 11923.523059077539, 10894.564217431214, 11015.779684406427, 11036.724081898017, 11372.943135284271, 11389.259698119928], "value": 7812.377534697246, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.1372750848197, 1357.0839683213828, 1365.180891465121, 1596.8562829345356, 1628.9185540722967, 6308.905366419507, 6543.47652187825, 7043.894341584881, 7657.195994420582, 7690.769276921701, 7059.717611295542, 7374.446916481272, 7418.591977441239, 7445.292697193771, 7450.739224127156, 2064.463239557718, 2108.894555272238, 2121.501447159924, 2127.6914847347125, 2129.6486079796814, 2084.1871670048695, 2108.546662467569, 2119.3218170185546, 2121.7984291492285, 2126.0539060118253, 2104.3476522278065, 2111.461577297787, 2115.132795553823, 2130.2437634639714, 2131.328631481086, 2034.2371610646007, 2053.712480252766, 2056.897155142237, 2057.362217712514, 2057.609054279682, 2014.1540552967788, 2023.7369142011444, 2032.867863588862, 2038.0930485933766, 2044.7648520420043, 7196.892046619305, 7253.310935461175, 7396.926030739677, 7500.474966752329, 7509.173990861001, 4305.311150215982, 4432.689711720181, 4444.555544445562, 4445.955540444586, 4446.355278484634, 2736.87684054218, 2779.166250124975, 2814.8311101333984, 2860.427914417104, 2865.6704478984975, 901.5987885391004, 907.4509921497531, 925.8703781470599, 936.4007035497287, 951.1819834941945, 9877.0, 10057.044580764743, 10082.89917100827, 10095.14191293741, 10113.646022389255, 3842.6733727632904, 3902.8144239226126, 4030.6775457963295, 4047.1298670785923, 4071.3689378146437, 8723.996740374938, 8724.214820666171, 8739.257163141077, 8753.956230218935, 8808.20726134651, 4313.288307429302, 4352.434183556117, 4368.803403846835, 4380.233459144637, 4484.327350897392, 3497.755157138976, 3614.7288953328607, 3953.426753120839, 4028.617281358266, 4031.173609410064, 3554.5023696682483, 3609.4766258892837, 3685.6130106338446, 3700.3524383232825, 3739.1773809761808, 1145.5303325636448, 1172.0857730969858, 1185.140772939612, 1222.7065504279087, 1223.3638507975802, 779.672537534237, 780.8321210939675, 785.4109417936547, 815.9061707903667, 820.2986446588201, 4728.95271047292, 4730.645201609893, 4854.538818812207, 4878.707277563358, 5032.496750325012, 359.90462527430253, 361.45600870689447, 365.12552436913444, 367.9889603311851, 369.46058754219143, 3212.2772376215166, 3315.469524876008, 3334.449815780369, 3375.578052743407, 3378.35811195872, 8839.204471597586, 9233.353665243369, 9277.304202184863, 9295.628174872929, 9319.673811416567, 9236.168744813, 9253.49105799174, 9262.120098590623, 9273.0, 9290.303227257982, 7104.573725576379, 7191.101112360955, 7227.710891564278, 7238.457115716343, 7244.348008679139, 4666.580007799314, 4814.711117332971, 4830.830920917751, 4868.14807408695, 4981.277714731271, 8390.790230244293, 8445.408821382443, 8500.829983400421, 8600.741977740678, 8646.82706345882, 8573.785655358666, 8668.176523230282, 8700.303975682056, 8711.04001599635, 8766.517841518778, 5448.56411487088, 5623.8875222496135, 6423.646699431576, 6452.225732911893, 6484.1894763154605, 6829.214640316229, 7040.647967601702, 7063.929360706327, 7252.166000909963, 7264.091988501437, 6137.508999279958, 6279.96860015697, 6379.011253255753, 6479.31967143462, 6566.9014964774615, 5824.271966004249, 5826.883462330815, 5856.502197313106, 5912.0, 5993.0, 5546.084895992116, 5649.4633009864, 5657.943420565742, 5658.292713410824, 5680.715964201856, 4057.695672824609, 4113.218488487178, 4209.34755112958, 4269.786510674392, 4380.299152135643, 4043.575424580494, 4150.813213405464, 4190.0, 4243.618074373321, 4298.871033868989], "value": 3836.9582605560645, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [272.41702756101944, 276.46779948598953, 279.9888004479821, 281.23083366991284, 284.7622235433412, 4815.808806992819, 4887.364642596466, 5001.749912504374, 5052.924206136906, 5068.72122033288, 4823.517648235174, 4912.606991440685, 4917.434495033072, 4934.901301973959, 4973.214999600226, 3860.4402361657544, 3872.1674839909415, 3882.378819388898, 3886.6113388661047, 3901.5708272090046, 3782.300274449222, 3799.35410980134, 3881.20435310762, 3881.9029524261978, 3884.864029758959, 3825.598312177223, 3860.652541271285, 3863.690904727629, 3866.2460820140086, 3879.243547508237, 3827.980860095696, 3836.5971572984713, 3845.7884816335372, 3859.26673931952, 3881.844726210948, 3105.8291793951325, 3221.935561288761, 3239.7408207343356, 3398.8640454381793, 3405.7105146062368, 4883.118959813692, 4893.853184404438, 4894.0, 4895.4125504939275, 4902.730349830758, 4287.142571485715, 4316.892077698083, 4317.9136417271475, 4320.200762858881, 4328.2209202343565, 5014.398272207359, 5164.870878228036, 5177.57616655419, 5189.714565698885, 5202.245674377232, 3521.683048525645, 3530.188056746937, 3533.8939831805087, 3535.9469607955903, 3542.5829668132696, 5432.429594892519, 5443.319585051869, 5450.482204190595, 5462.2079798429, 5469.15228139639, 3595.748297619194, 3596.3706351388923, 3598.3702852000797, 3604.9279014419567, 3610.6930910872343, 3557.7509574329547, 3588.1926566522325, 3624.2389098289655, 3665.865684839477, 3678.779273243614, 4266.658667306608, 4267.317229243306, 4274.10243848789, 4274.5939135782055, 4289.721168124062, 5116.590672746172, 5140.768665410065, 5174.974125129425, 5218.921716174261, 5238.0, 1177.8763229860913, 1206.7027944959204, 1236.1779416687802, 1244.0296568676447, 1300.0, 787.4763282417128, 813.6826637611337, 828.9668413263522, 838.6268110690806, 838.7693384319361, 4003.2193722223888, 4031.899202519902, 4032.8991775205855, 4038.2327357801923, 4047.2917239483563, 4705.670603057822, 4709.139889743532, 4710.52894710533, 4714.622830173578, 4721.386219791405, 4037.2934736421007, 4060.7563546187325, 4096.426500289962, 4097.7541347518645, 4101.5488296287385, 2420.9273721788372, 2501.8741566294875, 2523.8864251108744, 2525.19448594256, 2543.7456254374415, 4379.605835474823, 4397.802098905557, 4398.208322501981, 4401.383806267125, 4421.602055814992, 4745.694933893138, 4754.833580824655, 4758.809647614056, 4774.474807771142, 4795.736234507066, 4099.011979190091, 4404.581564751344, 4419.624331931757, 4432.534583868712, 4434.800433980414, 4721.976390118028, 4726.7636618169645, 4730.7871145797835, 4743.501932297059, 4746.477887432448, 4653.255479123324, 4657.439757681214, 4657.836975705834, 4664.626829853536, 4676.345311656439, 4427.959429534121, 4462.977685111554, 4464.642828573771, 4732.503087175797, 5083.949160508348, 3715.0, 3741.7567858089137, 3756.1924186300075, 3756.868509602151, 3760.680342170946, 5434.375046869661, 5437.564994800327, 5445.754941027584, 5447.0, 5454.236406903116, 5051.545360917535, 5113.0, 5172.250023746611, 5206.713630750345, 5267.947320526746, 5251.737413129405, 5314.4951229633125, 5318.7340632967425, 5328.387235467816, 5334.333208348957, 4976.900461990667, 5207.1668533034535, 5233.764480598306, 5255.684658920324, 5265.4997775211295, 5269.578433725216, 5311.3891902431715, 5313.0, 5351.759170837399, 5359.517643412111, 5227.686338819683, 5236.0, 5236.298203084089, 5236.700878446554, 5244.213367994831], "value": 3745.9201726774863, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.3414439569206, 611.2176414189838, 720.9783706488804, 734.042075092005, 742.3986570877593, 12446.190997585161, 12774.16967897086, 12907.419166137523, 13245.8013129803, 13374.66563335917, 12043.578474753385, 12227.14409991301, 12241.877581224186, 12257.08071894607, 12288.692782680437, 627.9120923070751, 743.4275607782018, 761.5050217358706, 762.7025460070577, 763.1338430880962, 642.251776680167, 734.9044624198873, 740.1229542991572, 741.1365758890886, 755.1391413788285, 790.2768966395741, 792.469045739356, 792.6908505682788, 792.8771040488733, 793.3573805217763, 785.8231897823001, 786.2373497707215, 787.2521104950263, 788.7081779741475, 789.6170357376697, 578.095280885413, 579.4408395897979, 580.7183515994739, 581.9272590926134, 583.565243893298, 12234.204776689487, 12254.264744115382, 12275.079369047357, 12299.139060265785, 12322.322272275022, 12252.326122063283, 12638.620841374774, 12843.29361885096, 12851.550195743104, 13140.802887956688, 10558.788824223473, 10585.047345738843, 10613.681589552325, 10819.67540973772, 10939.56241750329, 3044.558539011853, 3072.2472994116583, 3081.6456107547697, 3136.106209730216, 3154.763392745553, 63268.36731632671, 63549.68225158891, 64013.03980440344, 64329.0, 64675.67662161659, 10636.639409781628, 10712.143028557697, 10769.9461502692, 10784.838227426595, 10897.346159230472, 20212.191512339636, 20226.39320820378, 20235.797642023685, 20387.694184587242, 20439.795602044087, 6737.8652426951185, 6738.124043874265, 6780.288069752703, 6841.657917104125, 7220.638968051577, 3592.4790905319105, 3595.5146055282726, 3630.0743310455664, 3689.1330537323706, 3723.851045958131, 2826.773858091348, 2902.4630443368046, 2931.3844092740337, 2936.0898121582377, 2943.9705602943695, 486.406583967559, 488.5163687948905, 490.1936314762196, 490.58300444621784, 494.78971437139074, 585.6076428792719, 601.6420229963165, 609.0346800321452, 610.5237914426755, 617.3548641669466, 8025.3980951428875, 8220.260176584135, 8306.8338633227, 8391.0, 8563.357748168912, 580.2833500626723, 605.5246631394423, 621.8911690454153, 634.1629049654504, 646.7736292297752, 3848.5958974307855, 3885.825137868803, 3931.4495970564144, 3937.0, 3988.3419235826345, 93288.53355733179, 93972.0, 94684.0, 97399.51300243453, 97888.51055744676, 86126.56936715277, 86837.13162868291, 86901.56549217213, 87230.56384718162, 87795.56102219448, 46447.0, 73409.6329518349, 73679.63160184165, 74133.25866741371, 75478.62260688661, 7398.593077380796, 7461.664225109775, 7510.023696919584, 7607.657655405631, 7741.380689544935, 32196.678033220305, 41132.38301425541, 44060.0, 45068.32397514106, 45745.31382029206, 36012.63987360198, 37025.814870925475, 37475.25049499049, 54246.0, 56235.71882140563, 10438.68683939483, 10645.946770266099, 10897.618583349862, 10939.906009399314, 11742.765144697229, 12712.491500339884, 13115.672108197372, 13148.934255328662, 13313.334333283103, 13679.86320136786, 12247.203931744409, 12574.685632859251, 12737.93631031839, 12974.870251297743, 13274.867251327363, 12194.146409751233, 12432.564860229848, 12439.626811195678, 13135.0, 13379.665508362368, 10670.57317707283, 11134.721631959266, 11311.321320720454, 12360.381980901098, 12445.875541244472, 8890.555472226491, 9006.594703238501, 9153.405028673114, 9224.35429519954, 10001.249906257206, 10127.64553240633, 10403.0, 10457.111145552713, 10524.263301568817, 10604.734881628021], "value": 6445.030067799876, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 116.0, 118.0, 116.0, 116.0, 117.0, 118.0, 115.0, 117.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 127.0, 131.0, 179.0, 132.0, 126.0, 131.0, 131.0, 174.0, 125.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 164.0, 164.0, 164.0, 164.0, 162.0, 165.0, 164.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 118.0, 79.0, 80.0, 78.0, 79.0, 103.0, 76.0], "value": 84.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 110.0, 86.0, 83.0, 84.0, 102.0, 83.0, 83.0, 121.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 119.0, 118.0, 118.0, 118.0, 119.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 151.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 97.0, 97.0, 97.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 65.0, 66.0, 65.0, 66.0, 65.0, 64.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 68.0, 69.0, 67.0, 67.0, 66.0, 65.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 87.0, 83.0, 87.0, 88.0, 84.0, 83.0, 84.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 137.0, 134.0, 133.0, 150.0, 147.0, 150.0, 139.0, 176.0, 137.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 179.0, 178.0, 175.0, 174.0, 175.0, 174.0, 172.0, 173.0, 174.0], "value": 175.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 71.0, 69.0, 70.0, 71.0, 72.0, 74.0, 71.0, 70.0], "value": 71.0, "unit": "score"}]}]} 12:43:32 INFO - Return code: 0 12:43:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:43:33 ERROR - # TBPL SUCCESS # 12:43:33 INFO - Running post-action listener: _resource_record_post_action 12:43:33 INFO - [mozharness: 2016-09-29 19:43:33.018885Z] Finished run-tests step (success) 12:43:33 INFO - Running post-run listener: _resource_record_post_run 12:43:33 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 390475776; Read time: 20; Write time: 252368 12:43:33 INFO - TinderboxPrint: CPU usage
13.4% 12:43:33 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 12:43:33 INFO - TinderboxPrint: I/O write bytes / time
390,475,776 / 252,368 12:43:33 INFO - TinderboxPrint: CPU idle
8,283.1 (86.5%) 12:43:33 INFO - TinderboxPrint: CPU user
1,225.6 (12.8%) 12:43:33 INFO - TinderboxPrint: Swap in / out
0 / 0 12:43:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99090432; Read time: 0; Write time: 55192 12:43:33 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291385344; Read time: 8; Write time: 197176 12:43:33 INFO - Running post-run listener: _upload_blobber_files 12:43:33 INFO - Blob upload gear active. 12:43:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:43:33 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 12:43:33 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'] 12:43:33 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 12:43:34 INFO - (blobuploader) - INFO - Open directory for files ... 12:43:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:43:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:43:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:43:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:43:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:43:34 INFO - (blobuploader) - INFO - Done attempting. 12:43:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:43:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:43:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:43:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:43:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:43:35 INFO - (blobuploader) - INFO - Done attempting. 12:43:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:43:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:43:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:43:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:43:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:43:38 INFO - (blobuploader) - INFO - Done attempting. 12:43:38 INFO - (blobuploader) - INFO - Iteration through files over. 12:43:38 INFO - Return code: 0 12:43:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:43:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:43:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fd5b151e99699c630370714fe9831ad7da989918a7c33f050c42c185758688350cb6039da709913b65e2b0f51f0476aab8af041ce80f95bb74518b4aed7011c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa2ea185f5ce164376ef249f03499e1d3e094e60395236d3d20238e5981aafc57d3d1e40e3583cbe5b426718daa213387cc572922f11bf114af3d2dbb2f7f5d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d26856a996eb5c812fea00d6a21f1b3765060d30468cc93e3d38e799257b775be3344a39a5ba803fd1f6bc134b663910f5dbdadf10d9311bb5c0fdc828ce53d3"} 12:43:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:43:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:43:38 INFO - Contents: 12:43:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fd5b151e99699c630370714fe9831ad7da989918a7c33f050c42c185758688350cb6039da709913b65e2b0f51f0476aab8af041ce80f95bb74518b4aed7011c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa2ea185f5ce164376ef249f03499e1d3e094e60395236d3d20238e5981aafc57d3d1e40e3583cbe5b426718daa213387cc572922f11bf114af3d2dbb2f7f5d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d26856a996eb5c812fea00d6a21f1b3765060d30468cc93e3d38e799257b775be3344a39a5ba803fd1f6bc134b663910f5dbdadf10d9311bb5c0fdc828ce53d3"} 12:43:38 INFO - Running post-run listener: copy_logs_to_upload_dir 12:43:38 INFO - Copying logs to upload dir... 12:43:38 INFO - mkdir: /builds/slave/test/build/upload/logs 12:43:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.787822 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-29 12:43:38.472558) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 12:43:38.476759) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fd5b151e99699c630370714fe9831ad7da989918a7c33f050c42c185758688350cb6039da709913b65e2b0f51f0476aab8af041ce80f95bb74518b4aed7011c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa2ea185f5ce164376ef249f03499e1d3e094e60395236d3d20238e5981aafc57d3d1e40e3583cbe5b426718daa213387cc572922f11bf114af3d2dbb2f7f5d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d26856a996eb5c812fea00d6a21f1b3765060d30468cc93e3d38e799257b775be3344a39a5ba803fd1f6bc134b663910f5dbdadf10d9311bb5c0fdc828ce53d3"} build_url:https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011391 build_url: 'https://queue.taskcluster.net/v1/task/FROlHvPDRk-cZBkIayKlig/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fd5b151e99699c630370714fe9831ad7da989918a7c33f050c42c185758688350cb6039da709913b65e2b0f51f0476aab8af041ce80f95bb74518b4aed7011c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fa2ea185f5ce164376ef249f03499e1d3e094e60395236d3d20238e5981aafc57d3d1e40e3583cbe5b426718daa213387cc572922f11bf114af3d2dbb2f7f5d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d26856a996eb5c812fea00d6a21f1b3765060d30468cc93e3d38e799257b775be3344a39a5ba803fd1f6bc134b663910f5dbdadf10d9311bb5c0fdc828ce53d3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 12:43:38.502607) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:43:38.502955) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1475176973.892576-79267503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004590 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:43:38.585300) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 12:43:38.585614) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 12:43:38.585921) ========= ========= Total master_lag: 0.15 =========